builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-012 starttime: 1484177543.57 results: success (0) buildid: 20170111134216 builduid: 14a6a8960e3846de95bfafcecb454e39 revision: 4c681a167a5e3ce19021604e1b3661d2418b4966 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-11 15:32:23.565753) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-11 15:32:23.566236) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-11 15:32:23.566525) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-11 15:32:23.577555) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 15:32:23.577847) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1484177542.807542-714196871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-11 15:32:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2017-01-11 15:32:23 (46.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118572 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 15:32:23.707848) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 15:32:23.708189) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1484177542.807542-714196871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020677 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 15:32:23.757769) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 15:32:23.758145) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4c681a167a5e3ce19021604e1b3661d2418b4966 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4c681a167a5e3ce19021604e1b3661d2418b4966 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1484177542.807542-714196871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-11 15:32:24,040 truncating revision to first 12 chars 2017-01-11 15:32:24,040 Setting DEBUG logging. 2017-01-11 15:32:24,040 attempt 1/10 2017-01-11 15:32:24,040 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4c681a167a5e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-11 15:32:24,331 unpacking tar archive at: mozilla-aurora-4c681a167a5e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.609747 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 15:32:24.382360) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-11 15:32:24.382801) ========= script_repo_revision: 4c681a167a5e3ce19021604e1b3661d2418b4966 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-11 15:32:24.383352) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-11 15:32:24.383699) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-11 15:32:24.394440) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-01-11 15:32:24.394891) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1484177542.807542-714196871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:32:24 INFO - MultiFileLogger online at 20170111 15:32:24 in /builds/slave/test 15:32:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 15:32:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:32:24 INFO - {'append_to_log': False, 15:32:24 INFO - 'base_work_dir': '/builds/slave/test', 15:32:24 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:32:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:32:24 INFO - 'branch': 'Mozilla-Aurora', 15:32:24 INFO - 'buildbot_json_path': 'buildprops.json', 15:32:24 INFO - 'config_files': ('talos/linux_config.py',), 15:32:24 INFO - 'default_actions': ('clobber', 15:32:24 INFO - 'read-buildbot-config', 15:32:24 INFO - 'download-and-extract', 15:32:24 INFO - 'populate-webroot', 15:32:24 INFO - 'create-virtualenv', 15:32:24 INFO - 'install', 15:32:24 INFO - 'run-tests'), 15:32:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:32:24 INFO - 'download_minidump_stackwalk': True, 15:32:24 INFO - 'download_symbols': 'ondemand', 15:32:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:32:24 INFO - 'tooltool.py': '/tools/tooltool.py', 15:32:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:32:24 INFO - '/tools/misc-python/virtualenv.py')}, 15:32:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:32:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:32:24 INFO - 'installer_path': 'installer.exe', 15:32:24 INFO - 'log_level': 'info', 15:32:24 INFO - 'log_name': 'talos', 15:32:24 INFO - 'log_to_console': True, 15:32:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:32:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:32:24 INFO - 'opt_config_files': (), 15:32:24 INFO - 'pip_index': False, 15:32:24 INFO - 'sps_profile': False, 15:32:24 INFO - 'sps_profile_interval': 0, 15:32:24 INFO - 'suite': 'dromaeojs', 15:32:24 INFO - 'system_bits': '32', 15:32:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:32:24 INFO - 'title': 'talos-linux64-ix-012', 15:32:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:32:24 INFO - 'use_talos_json': True, 15:32:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:32:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:32:24 INFO - 'work_dir': 'build'} 15:32:24 INFO - [mozharness: 2017-01-11 23:32:24.776862Z] Running clobber step. 15:32:24 INFO - Running pre-action listener: _resource_record_pre_action 15:32:24 INFO - Running main action method: clobber 15:32:24 INFO - rmtree: /builds/slave/test/build 15:32:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:32:25 INFO - Running post-action listener: _resource_record_post_action 15:32:25 INFO - [mozharness: 2017-01-11 23:32:25.241252Z] Finished clobber step (success) 15:32:25 INFO - [mozharness: 2017-01-11 23:32:25.241352Z] Running read-buildbot-config step. 15:32:25 INFO - Running pre-action listener: _resource_record_pre_action 15:32:25 INFO - Running main action method: read_buildbot_config 15:32:25 INFO - Using buildbot properties: 15:32:25 INFO - { 15:32:25 INFO - "project": "", 15:32:25 INFO - "product": "firefox", 15:32:25 INFO - "script_repo_revision": "production", 15:32:25 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 15:32:25 INFO - "repository": "", 15:32:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 15:32:25 INFO - "buildid": "20170111134216", 15:32:25 INFO - "pgo_build": "True", 15:32:25 INFO - "basedir": "/builds/slave/test", 15:32:25 INFO - "buildnumber": 731, 15:32:25 INFO - "slavename": "talos-linux64-ix-012", 15:32:25 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:32:25 INFO - "platform": "ubuntu64_hw", 15:32:25 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 15:32:25 INFO - "branch": "mozilla-aurora", 15:32:25 INFO - "repo_path": "releases/mozilla-aurora", 15:32:25 INFO - "revision": "4c681a167a5e3ce19021604e1b3661d2418b4966", 15:32:25 INFO - "stage_platform": "linux64-pgo", 15:32:25 INFO - "builduid": "14a6a8960e3846de95bfafcecb454e39", 15:32:25 INFO - "slavebuilddir": "test" 15:32:25 INFO - } 15:32:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/NDRFhHCOROiOUFlkRacjyg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 15:32:25 INFO - Running post-action listener: _resource_record_post_action 15:32:25 INFO - [mozharness: 2017-01-11 23:32:25.243795Z] Finished read-buildbot-config step (success) 15:32:25 INFO - [mozharness: 2017-01-11 23:32:25.243883Z] Running download-and-extract step. 15:32:25 INFO - Running pre-action listener: _resource_record_pre_action 15:32:25 INFO - Running main action method: download_and_extract 15:32:25 INFO - mkdir: /builds/slave/test/build/tests 15:32:25 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')]} 15:32:25 INFO - trying https://queue.taskcluster.net/v1/task/NDRFhHCOROiOUFlkRacjyg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 15:32:25 INFO - Downloading https://queue.taskcluster.net/v1/task/NDRFhHCOROiOUFlkRacjyg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 15:32:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NDRFhHCOROiOUFlkRacjyg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:32:25 INFO - Downloaded 1361 bytes. 15:32:25 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 15:32:25 INFO - Using the following test package requirements: 15:32:25 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 15:32:25 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:32:25 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 15:32:25 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:32:25 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 15:32:25 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:32:25 INFO - u'jsshell-linux-x86_64.zip'], 15:32:25 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:32:25 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 15:32:25 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 15:32:25 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:32:25 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 15:32:25 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:32:25 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 15:32:25 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:32:25 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 15:32:25 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:32:25 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 15:32:25 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:32:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NDRFhHCOROiOUFlkRacjyg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 15:32:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NDRFhHCOROiOUFlkRacjyg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:32:25 INFO - Fetch https://queue.taskcluster.net/v1/task/NDRFhHCOROiOUFlkRacjyg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 15:32:26 INFO - Http code: 200 15:32:26 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 15:32:26 INFO - x-amz-cf-id: -RZGDQZw9lk0ai1e76tqF3tw9sCOxqJhY_hRw9hXT8IyZo1tQdP34A== 15:32:26 INFO - x-amz-version-id: ZATGnge2iE8hd2k4TrjY4gUkvJ8xpeU6 15:32:26 INFO - Expected file size: 21945440 15:32:26 INFO - Obtained file size: 21945440 15:32:30 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:32:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NDRFhHCOROiOUFlkRacjyg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 15:32:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NDRFhHCOROiOUFlkRacjyg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:32:30 INFO - Fetch https://queue.taskcluster.net/v1/task/NDRFhHCOROiOUFlkRacjyg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 15:32:31 INFO - Http code: 200 15:32:31 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 15:32:31 INFO - x-amz-cf-id: 3bwyLsS4U5FA-IBUj-yPSBK_bMlRwr496L-9Yu5T7d3TBVV0zC5bbg== 15:32:31 INFO - x-amz-version-id: ZATGnge2iE8hd2k4TrjY4gUkvJ8xpeU6 15:32:31 INFO - Expected file size: 21945440 15:32:31 INFO - Obtained file size: 21945440 15:32:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NDRFhHCOROiOUFlkRacjyg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 15:32:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NDRFhHCOROiOUFlkRacjyg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:32:35 INFO - Fetch https://queue.taskcluster.net/v1/task/NDRFhHCOROiOUFlkRacjyg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 15:32:36 INFO - Http code: 200 15:32:36 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 15:32:36 INFO - x-amz-cf-id: HZTpUtI5CT8G0Uz2uw3cxBgEtH1CpQnFOu9TmrOdvBWulPKxupv5zQ== 15:32:36 INFO - x-amz-version-id: uDkspRECGf0tAG_CO8qldkvgOSQlQA3u 15:32:36 INFO - Expected file size: 14409038 15:32:36 INFO - Obtained file size: 14409038 15:32: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')]} 15:32:36 INFO - trying https://queue.taskcluster.net/v1/task/NDRFhHCOROiOUFlkRacjyg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 15:32:36 INFO - Downloading https://queue.taskcluster.net/v1/task/NDRFhHCOROiOUFlkRacjyg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 15:32:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NDRFhHCOROiOUFlkRacjyg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:32:38 INFO - Downloaded 64143429 bytes. 15:32:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NDRFhHCOROiOUFlkRacjyg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 15:32:38 INFO - mkdir: /builds/slave/test/properties 15:32:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:32:38 INFO - Writing to file /builds/slave/test/properties/build_url 15:32:38 INFO - Contents: 15:32:38 INFO - build_url:https://queue.taskcluster.net/v1/task/NDRFhHCOROiOUFlkRacjyg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 15:32:38 INFO - Running post-action listener: _resource_record_post_action 15:32:38 INFO - Running post-action listener: set_extra_try_arguments 15:32:38 INFO - [mozharness: 2017-01-11 23:32:38.617301Z] Finished download-and-extract step (success) 15:32:38 INFO - [mozharness: 2017-01-11 23:32:38.617624Z] Running populate-webroot step. 15:32:38 INFO - Running pre-action listener: _resource_record_pre_action 15:32:38 INFO - Running main action method: populate_webroot 15:32:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:32:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:32:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:32:38 INFO - '--tppagecycles', 15:32:38 INFO - '7'], 15:32:38 INFO - 'tests': ['tsvgm']}}, 15:32:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:32:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:32:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:32:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:32:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:32:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:32:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:38 INFO - 'talos_options': ['--disable-e10s'], 15:32:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:32:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:32:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:38 INFO - 'talos_options': ['--disable-e10s'], 15:32:38 INFO - 'tests': ['damp', 'tps']}, 15:32:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:38 INFO - 'tests': ['damp', 'tps']}, 15:32:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:32:38 INFO - 'tests': ['dromaeo_dom']}, 15:32:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:32:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:32:38 INFO - 'tests': ['basic_compositor_video']}, 15:32:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:32:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:32:38 INFO - 'tests': ['a11yr', 15:32:38 INFO - 'ts_paint', 15:32:38 INFO - 'tpaint', 15:32:38 INFO - 'sessionrestore', 15:32:38 INFO - 'sessionrestore_no_auto_restore', 15:32:38 INFO - 'tabpaint']}, 15:32:38 INFO - 'other-e10s': {'tests': ['a11yr', 15:32:38 INFO - 'ts_paint', 15:32:38 INFO - 'tpaint', 15:32:38 INFO - 'sessionrestore', 15:32:38 INFO - 'sessionrestore_no_auto_restore', 15:32:38 INFO - 'tabpaint']}, 15:32:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:32:38 INFO - 'ts_paint', 15:32:38 INFO - 'tpaint', 15:32:38 INFO - 'sessionrestore', 15:32:38 INFO - 'sessionrestore_no_auto_restore', 15:32:38 INFO - 'tabpaint']}, 15:32:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:32:38 INFO - 'ts_paint', 15:32:38 INFO - 'tpaint', 15:32:38 INFO - 'sessionrestore', 15:32:38 INFO - 'sessionrestore_no_auto_restore', 15:32:38 INFO - 'tabpaint']}, 15:32:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:32:38 INFO - 'tests': ['a11yr', 15:32:38 INFO - 'ts_paint', 15:32:38 INFO - 'tpaint', 15:32:38 INFO - 'sessionrestore', 15:32:38 INFO - 'sessionrestore_no_auto_restore', 15:32:38 INFO - 'tabpaint']}, 15:32:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:32:38 INFO - 'tests': ['a11yr', 15:32:38 INFO - 'ts_paint', 15:32:38 INFO - 'tpaint', 15:32:38 INFO - 'sessionrestore', 15:32:38 INFO - 'sessionrestore_no_auto_restore', 15:32:38 INFO - 'tabpaint']}, 15:32:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:32:38 INFO - 'tests': ['tsvgx', 15:32:38 INFO - 'tsvgr_opacity', 15:32:38 INFO - 'tart', 15:32:38 INFO - 'tscrollx', 15:32:38 INFO - 'cart']}, 15:32:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:32:38 INFO - 'tsvgr_opacity', 15:32:38 INFO - 'tart', 15:32:38 INFO - 'tscrollx', 15:32:38 INFO - 'cart']}, 15:32:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:38 INFO - 'talos_options': ['--disable-e10s'], 15:32:38 INFO - 'tests': ['tp5o']}, 15:32:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:38 INFO - 'tests': ['tp5o']}, 15:32:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:38 INFO - 'talos_options': ['--disable-e10s', 15:32:38 INFO - '--xperf_path', 15:32:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:32:38 INFO - 'tests': ['tp5n']}, 15:32:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:38 INFO - 'talos_options': ['--xperf_path', 15:32:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:32:38 INFO - 'tests': ['tp5n']}}, 15:32:38 INFO - 'talos.zip': {'path': '', 15:32:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:32:38 INFO - Running post-action listener: _resource_record_post_action 15:32:38 INFO - [mozharness: 2017-01-11 23:32:38.633246Z] Finished populate-webroot step (success) 15:32:38 INFO - [mozharness: 2017-01-11 23:32:38.633333Z] Running create-virtualenv step. 15:32:38 INFO - Running pre-action listener: _resource_record_pre_action 15:32:38 INFO - Running main action method: create_virtualenv 15:32:38 INFO - Creating virtualenv /builds/slave/test/build/venv 15:32:38 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 15:32:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:32:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:32:38 INFO - Using real prefix '/usr' 15:32:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:32:39 INFO - Installing distribute.............................................................................................................................................................................................done. 15:32:41 INFO - Installing pip.................done. 15:32:41 INFO - Return code: 0 15:32:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:32:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:32:41 INFO - Reading from file tmpfile_stdout 15:32:41 INFO - Output received: 15:32:41 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) 15:32:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:32: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')]} 15:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32: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')]} 15:32:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba93e6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ecca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e9f60>, '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 0x21ead40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21eb1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1484177542.807542-714196871', '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 15:32: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', 'pip>=1.5'] in /builds/slave/test/build 15:32: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 pip>=1.5 15:32:41 INFO - Using env: {'DISPLAY': ':0', 15:32:41 INFO - 'HOME': '/home/cltbld', 15:32:41 INFO - 'LANG': 'en_US.UTF-8', 15:32:41 INFO - 'LANGUAGE': 'en_US:en', 15:32:41 INFO - 'LOGNAME': 'cltbld', 15:32:41 INFO - 'MAIL': '/var/mail/cltbld', 15:32:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:41 INFO - 'MOZ_NO_REMOTE': '1', 15:32:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:41 INFO - 'NO_EM_RESTART': '1', 15:32:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:41 INFO - 'PWD': '/builds/slave/test', 15:32:41 INFO - 'SHELL': '/bin/bash', 15:32:41 INFO - 'SHLVL': '1', 15:32:41 INFO - 'TERM': 'linux', 15:32:41 INFO - 'TMOUT': '86400', 15:32:41 INFO - 'USER': 'cltbld', 15:32:41 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1484177542.807542-714196871', 15:32:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:41 INFO - '_': '/tools/buildbot/bin/python'} 15:32:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:41 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 15:32:41 INFO - Cleaning up... 15:32:41 INFO - Return code: 0 15:32:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:32: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')]} 15:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32: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')]} 15:32:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32: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', '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 0x7fba93e6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ecca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e9f60>, '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 0x21ead40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21eb1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1484177542.807542-714196871', '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 15:32: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', 'psutil>=3.1.1'] in /builds/slave/test/build 15:32: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 psutil>=3.1.1 15:32:41 INFO - Using env: {'DISPLAY': ':0', 15:32:41 INFO - 'HOME': '/home/cltbld', 15:32:41 INFO - 'LANG': 'en_US.UTF-8', 15:32:41 INFO - 'LANGUAGE': 'en_US:en', 15:32:41 INFO - 'LOGNAME': 'cltbld', 15:32:41 INFO - 'MAIL': '/var/mail/cltbld', 15:32:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:41 INFO - 'MOZ_NO_REMOTE': '1', 15:32:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:41 INFO - 'NO_EM_RESTART': '1', 15:32:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:41 INFO - 'PWD': '/builds/slave/test', 15:32:41 INFO - 'SHELL': '/bin/bash', 15:32:41 INFO - 'SHLVL': '1', 15:32:41 INFO - 'TERM': 'linux', 15:32:41 INFO - 'TMOUT': '86400', 15:32:41 INFO - 'USER': 'cltbld', 15:32:41 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1484177542.807542-714196871', 15:32:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:41 INFO - '_': '/tools/buildbot/bin/python'} 15:32:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:41 INFO - Downloading/unpacking psutil>=3.1.1 15:32: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 15:32: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 15:32: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 15:32: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 15:32: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 15:32: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 15:32:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:32:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:32:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:32:43 INFO - Installing collected packages: psutil 15:32:43 INFO - Running setup.py install for psutil 15:32:44 INFO - building 'psutil._psutil_linux' extension 15:32:44 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 15:32:44 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 15:32:44 INFO - building 'psutil._psutil_posix' extension 15:32:44 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 15:32:44 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 15:32:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:32:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:32:44 INFO - Successfully installed psutil 15:32:44 INFO - Cleaning up... 15:32:44 INFO - Return code: 0 15:32:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:32:44 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')]} 15:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:44 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')]} 15:32:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:44 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 0x7fba93e6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ecca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e9f60>, '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 0x21ead40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21eb1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1484177542.807542-714196871', '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 15:32:44 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 15:32:44 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 15:32:44 INFO - Using env: {'DISPLAY': ':0', 15:32:44 INFO - 'HOME': '/home/cltbld', 15:32:44 INFO - 'LANG': 'en_US.UTF-8', 15:32:44 INFO - 'LANGUAGE': 'en_US:en', 15:32:44 INFO - 'LOGNAME': 'cltbld', 15:32:44 INFO - 'MAIL': '/var/mail/cltbld', 15:32:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:44 INFO - 'MOZ_NO_REMOTE': '1', 15:32:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:44 INFO - 'NO_EM_RESTART': '1', 15:32:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:44 INFO - 'PWD': '/builds/slave/test', 15:32:44 INFO - 'SHELL': '/bin/bash', 15:32:44 INFO - 'SHLVL': '1', 15:32:44 INFO - 'TERM': 'linux', 15:32:44 INFO - 'TMOUT': '86400', 15:32:44 INFO - 'USER': 'cltbld', 15:32:44 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1484177542.807542-714196871', 15:32:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:44 INFO - '_': '/tools/buildbot/bin/python'} 15:32:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:32: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 15:32: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 15:32: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 15:32: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 15:32: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 15:32: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 15:32:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:32:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:32:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:32:46 INFO - Installing collected packages: mozsystemmonitor 15:32:46 INFO - Running setup.py install for mozsystemmonitor 15:32:46 INFO - Successfully installed mozsystemmonitor 15:32:46 INFO - Cleaning up... 15:32:46 INFO - Return code: 0 15:32:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:32:46 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')]} 15:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:46 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')]} 15:32:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:46 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 0x7fba93e6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ecca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e9f60>, '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 0x21ead40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21eb1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1484177542.807542-714196871', '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 15:32:46 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 15:32:46 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 15:32:46 INFO - Using env: {'DISPLAY': ':0', 15:32:46 INFO - 'HOME': '/home/cltbld', 15:32:46 INFO - 'LANG': 'en_US.UTF-8', 15:32:46 INFO - 'LANGUAGE': 'en_US:en', 15:32:46 INFO - 'LOGNAME': 'cltbld', 15:32:46 INFO - 'MAIL': '/var/mail/cltbld', 15:32:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:47 INFO - 'MOZ_NO_REMOTE': '1', 15:32:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:47 INFO - 'NO_EM_RESTART': '1', 15:32:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:47 INFO - 'PWD': '/builds/slave/test', 15:32:47 INFO - 'SHELL': '/bin/bash', 15:32:47 INFO - 'SHLVL': '1', 15:32:47 INFO - 'TERM': 'linux', 15:32:47 INFO - 'TMOUT': '86400', 15:32:47 INFO - 'USER': 'cltbld', 15:32:47 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1484177542.807542-714196871', 15:32:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:47 INFO - '_': '/tools/buildbot/bin/python'} 15:32:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:47 INFO - Downloading/unpacking jsonschema==2.5.1 15:32:47 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 15:32:47 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 15:32:47 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 15:32:47 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 15:32:47 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 15:32:47 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 15:32:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:32:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:32:49 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 15:32:49 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 15:32:49 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 15:32:49 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 15:32:49 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 15:32:49 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 15:32:49 INFO - Downloading functools32-3.2.3-2.tar.gz 15:32:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:32:49 INFO - warning: no files found matching '*.txt' 15:32:49 INFO - no previously-included directories found matching 'build' 15:32:49 INFO - no previously-included directories found matching 'dist' 15:32:49 INFO - no previously-included directories found matching '.git*' 15:32:49 INFO - Installing collected packages: jsonschema, functools32 15:32:49 INFO - Running setup.py install for functools32 15:32:49 INFO - warning: no files found matching '*.txt' 15:32:49 INFO - no previously-included directories found matching 'build' 15:32:49 INFO - no previously-included directories found matching 'dist' 15:32:49 INFO - no previously-included directories found matching '.git*' 15:32:49 INFO - Successfully installed jsonschema functools32 15:32:49 INFO - Cleaning up... 15:32:49 INFO - Return code: 0 15:32:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:32:49 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')]} 15:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:49 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')]} 15:32:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:49 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 0x7fba93e6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ecca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e9f60>, '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 0x21ead40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21eb1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1484177542.807542-714196871', '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 15:32:49 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 15:32:49 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 15:32:49 INFO - Using env: {'DISPLAY': ':0', 15:32:49 INFO - 'HOME': '/home/cltbld', 15:32:49 INFO - 'LANG': 'en_US.UTF-8', 15:32:49 INFO - 'LANGUAGE': 'en_US:en', 15:32:49 INFO - 'LOGNAME': 'cltbld', 15:32:49 INFO - 'MAIL': '/var/mail/cltbld', 15:32:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:49 INFO - 'MOZ_NO_REMOTE': '1', 15:32:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:49 INFO - 'NO_EM_RESTART': '1', 15:32:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:49 INFO - 'PWD': '/builds/slave/test', 15:32:49 INFO - 'SHELL': '/bin/bash', 15:32:49 INFO - 'SHLVL': '1', 15:32:49 INFO - 'TERM': 'linux', 15:32:49 INFO - 'TMOUT': '86400', 15:32:49 INFO - 'USER': 'cltbld', 15:32:49 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1484177542.807542-714196871', 15:32:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:49 INFO - '_': '/tools/buildbot/bin/python'} 15:32:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:32:49 INFO - Cleaning up... 15:32:49 INFO - Return code: 0 15:32:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:32:49 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')]} 15:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:49 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')]} 15:32:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:49 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 0x7fba93e6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ecca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e9f60>, '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 0x21ead40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21eb1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1484177542.807542-714196871', '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 15:32:49 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 15:32:49 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 15:32:49 INFO - Using env: {'DISPLAY': ':0', 15:32:49 INFO - 'HOME': '/home/cltbld', 15:32:49 INFO - 'LANG': 'en_US.UTF-8', 15:32:49 INFO - 'LANGUAGE': 'en_US:en', 15:32:49 INFO - 'LOGNAME': 'cltbld', 15:32:49 INFO - 'MAIL': '/var/mail/cltbld', 15:32:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:49 INFO - 'MOZ_NO_REMOTE': '1', 15:32:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:49 INFO - 'NO_EM_RESTART': '1', 15:32:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:49 INFO - 'PWD': '/builds/slave/test', 15:32:49 INFO - 'SHELL': '/bin/bash', 15:32:49 INFO - 'SHLVL': '1', 15:32:49 INFO - 'TERM': 'linux', 15:32:49 INFO - 'TMOUT': '86400', 15:32:49 INFO - 'USER': 'cltbld', 15:32:49 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1484177542.807542-714196871', 15:32:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:49 INFO - '_': '/tools/buildbot/bin/python'} 15:32:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:50 INFO - Downloading/unpacking blobuploader==1.2.4 15:32:50 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 15:32:50 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 15:32:50 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 15:32:50 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 15:32:50 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 15:32:50 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 15:32:52 INFO - Downloading blobuploader-1.2.4.tar.gz 15:32:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:32:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:32: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 15:32: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 15:32: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 15:32: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 15:32: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 15:32: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 15:32:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:32:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:32: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 15:32: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 15:32: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 15:32: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 15:32: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 15:32: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 15:32:52 INFO - Downloading docopt-0.6.1.tar.gz 15:32:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:32:53 INFO - Installing collected packages: blobuploader, requests, docopt 15:32:53 INFO - Running setup.py install for blobuploader 15:32:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:32:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:32:53 INFO - Running setup.py install for requests 15:32:53 INFO - Running setup.py install for docopt 15:32:53 INFO - Successfully installed blobuploader requests docopt 15:32:53 INFO - Cleaning up... 15:32:53 INFO - Return code: 0 15:32:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:32:53 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')]} 15:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:53 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')]} 15:32:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:53 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 0x7fba93e6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ecca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e9f60>, '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 0x21ead40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21eb1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1484177542.807542-714196871', '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 15:32:53 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 15:32:53 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 15:32:53 INFO - Using env: {'DISPLAY': ':0', 15:32:53 INFO - 'HOME': '/home/cltbld', 15:32:53 INFO - 'LANG': 'en_US.UTF-8', 15:32:53 INFO - 'LANGUAGE': 'en_US:en', 15:32:53 INFO - 'LOGNAME': 'cltbld', 15:32:53 INFO - 'MAIL': '/var/mail/cltbld', 15:32:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:53 INFO - 'MOZ_NO_REMOTE': '1', 15:32:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:53 INFO - 'NO_EM_RESTART': '1', 15:32:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:53 INFO - 'PWD': '/builds/slave/test', 15:32:53 INFO - 'SHELL': '/bin/bash', 15:32:53 INFO - 'SHLVL': '1', 15:32:53 INFO - 'TERM': 'linux', 15:32:53 INFO - 'TMOUT': '86400', 15:32:53 INFO - 'USER': 'cltbld', 15:32:53 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1484177542.807542-714196871', 15:32:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:53 INFO - '_': '/tools/buildbot/bin/python'} 15:32:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:32:53 INFO - Running setup.py (path:/tmp/pip-mrvFIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:32:53 INFO - Running setup.py (path:/tmp/pip-5Xo2Og-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:32:54 INFO - Running setup.py (path:/tmp/pip-zfdm8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:32:54 INFO - Running setup.py (path:/tmp/pip-CfQ6lC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:32:54 INFO - Running setup.py (path:/tmp/pip-LN7hMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:32:54 INFO - Running setup.py (path:/tmp/pip-iMOH8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:32:54 INFO - Running setup.py (path:/tmp/pip-RRj6rC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:32:54 INFO - Running setup.py (path:/tmp/pip-QloEM2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:32:54 INFO - Running setup.py (path:/tmp/pip-uqllzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:32:54 INFO - Running setup.py (path:/tmp/pip-wj0hQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:32:54 INFO - Running setup.py (path:/tmp/pip-R83TpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:32:54 INFO - Running setup.py (path:/tmp/pip-RlEziZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:32:54 INFO - Running setup.py (path:/tmp/pip-Fs5Wlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:32:54 INFO - Running setup.py (path:/tmp/pip-Wiz3kW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:32:54 INFO - Running setup.py (path:/tmp/pip-WWh0J7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:32:54 INFO - Running setup.py (path:/tmp/pip-orPrVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:32:55 INFO - Running setup.py (path:/tmp/pip-DHR0aD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:32:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:32:55 INFO - Running setup.py install for manifestparser 15:32:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:32:55 INFO - Running setup.py install for mozcrash 15:32:55 INFO - Running setup.py install for mozdebug 15:32:55 INFO - Running setup.py install for mozdevice 15:32:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:32:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:32:55 INFO - Running setup.py install for mozfile 15:32:55 INFO - Running setup.py install for mozhttpd 15:32:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:32:55 INFO - Running setup.py install for mozinfo 15:32:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:32:55 INFO - Running setup.py install for mozInstall 15:32:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:32:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:32:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:32:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:32:55 INFO - Running setup.py install for mozleak 15:32:56 INFO - Running setup.py install for mozlog 15:32:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:32:56 INFO - Running setup.py install for moznetwork 15:32:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:32:56 INFO - Running setup.py install for mozprocess 15:32:56 INFO - Running setup.py install for mozprofile 15:32:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:32:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:32:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:32:56 INFO - Running setup.py install for mozrunner 15:32:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:32:56 INFO - Running setup.py install for mozscreenshot 15:32:56 INFO - Running setup.py install for moztest 15:32:56 INFO - Running setup.py install for mozversion 15:32:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:32:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:32:56 INFO - Cleaning up... 15:32:56 INFO - Return code: 0 15:32:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:56 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 0x7fba93e6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ecca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e9f60>, '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 0x21ead40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21eb1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1484177542.807542-714196871', '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 15:32:56 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 15:32:56 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 15:32:56 INFO - Using env: {'DISPLAY': ':0', 15:32:56 INFO - 'HOME': '/home/cltbld', 15:32:56 INFO - 'LANG': 'en_US.UTF-8', 15:32:56 INFO - 'LANGUAGE': 'en_US:en', 15:32:56 INFO - 'LOGNAME': 'cltbld', 15:32:56 INFO - 'MAIL': '/var/mail/cltbld', 15:32:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:56 INFO - 'MOZ_NO_REMOTE': '1', 15:32:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:56 INFO - 'NO_EM_RESTART': '1', 15:32:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:56 INFO - 'PWD': '/builds/slave/test', 15:32:56 INFO - 'SHELL': '/bin/bash', 15:32:56 INFO - 'SHLVL': '1', 15:32:56 INFO - 'TERM': 'linux', 15:32:56 INFO - 'TMOUT': '86400', 15:32:56 INFO - 'USER': 'cltbld', 15:32:56 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1484177542.807542-714196871', 15:32:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:56 INFO - '_': '/tools/buildbot/bin/python'} 15:32:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:32:57 INFO - Running setup.py (path:/tmp/pip-PaFx4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:32:57 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)) 15:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:32:57 INFO - Running setup.py (path:/tmp/pip-5Bv6EY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:32:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:32:57 INFO - Running setup.py (path:/tmp/pip-E7EjzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:32:57 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)) 15:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:32:57 INFO - Running setup.py (path:/tmp/pip-JQ5fW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:32:57 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)) 15:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:32:57 INFO - Running setup.py (path:/tmp/pip-yKkNgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:32:57 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)) 15:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:32:57 INFO - Running setup.py (path:/tmp/pip-Zn0xev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:32:57 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)) 15:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:32:57 INFO - Running setup.py (path:/tmp/pip-SV_jq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:32:57 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)) 15:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:32:57 INFO - Running setup.py (path:/tmp/pip-NEP9XT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:32:57 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)) 15:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:32:57 INFO - Running setup.py (path:/tmp/pip-Lrj9Zf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:32:57 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)) 15:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:32:57 INFO - Running setup.py (path:/tmp/pip-fTQPAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:32:57 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)) 15:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:32:57 INFO - Running setup.py (path:/tmp/pip-qcTpdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:32:57 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)) 15:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:32:57 INFO - Running setup.py (path:/tmp/pip-r1mLEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:32:58 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)) 15:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:32:58 INFO - Running setup.py (path:/tmp/pip-k_N6kk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:32:58 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)) 15:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:32:58 INFO - Running setup.py (path:/tmp/pip-c7ySW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:32:58 INFO - Running setup.py (path:/tmp/pip-FTUOCA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:32:58 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)) 15:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:32:58 INFO - Running setup.py (path:/tmp/pip-1iyejB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 15:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:32:58 INFO - Running setup.py (path:/tmp/pip-XMLM9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:32:58 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)) 15:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:32:58 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)) 15:32:58 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)) 15:32:58 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)) 15:32:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:32:58 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 15:32:58 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 15:32:58 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 15:32:58 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 15:32:58 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 15:32:58 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 15:33:00 INFO - Downloading blessings-1.6.tar.gz 15:33:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:33:00 INFO - Installing collected packages: blessings 15:33:00 INFO - Running setup.py install for blessings 15:33:00 INFO - Successfully installed blessings 15:33:00 INFO - Cleaning up... 15:33:00 INFO - Return code: 0 15:33:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:33:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:33:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:33:00 INFO - Reading from file tmpfile_stdout 15:33:00 INFO - Current package versions: 15:33:00 INFO - argparse == 1.2.1 15:33:00 INFO - blessings == 1.6 15:33:00 INFO - blobuploader == 1.2.4 15:33:00 INFO - docopt == 0.6.1 15:33:00 INFO - functools32 == 3.2.3-2 15:33:00 INFO - jsonschema == 2.5.1 15:33:00 INFO - manifestparser == 1.1 15:33:00 INFO - mozInstall == 1.12 15:33:00 INFO - mozcrash == 1.0 15:33:00 INFO - mozdebug == 0.1 15:33:00 INFO - mozdevice == 0.48 15:33:00 INFO - mozfile == 1.2 15:33:00 INFO - mozhttpd == 0.7 15:33:00 INFO - mozinfo == 0.9 15:33:00 INFO - mozleak == 0.1 15:33:00 INFO - mozlog == 3.4 15:33:00 INFO - moznetwork == 0.27 15:33:00 INFO - mozprocess == 0.23 15:33:00 INFO - mozprofile == 0.28 15:33:00 INFO - mozrunner == 6.13 15:33:00 INFO - mozscreenshot == 0.1 15:33:00 INFO - mozsystemmonitor == 0.3 15:33:00 INFO - moztest == 0.8 15:33:00 INFO - mozversion == 1.4 15:33:00 INFO - psutil == 3.1.1 15:33:00 INFO - requests == 1.2.3 15:33:00 INFO - wsgiref == 0.1.2 15:33:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:00 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 0x7fba93e6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ecca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e9f60>, '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 0x21ead40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21eb1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1484177542.807542-714196871', '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 15:33:00 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 15:33:00 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 15:33:00 INFO - Using env: {'DISPLAY': ':0', 15:33:00 INFO - 'HOME': '/home/cltbld', 15:33:00 INFO - 'LANG': 'en_US.UTF-8', 15:33:00 INFO - 'LANGUAGE': 'en_US:en', 15:33:00 INFO - 'LOGNAME': 'cltbld', 15:33:00 INFO - 'MAIL': '/var/mail/cltbld', 15:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:00 INFO - 'MOZ_NO_REMOTE': '1', 15:33:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:00 INFO - 'NO_EM_RESTART': '1', 15:33:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:00 INFO - 'PWD': '/builds/slave/test', 15:33:00 INFO - 'SHELL': '/bin/bash', 15:33:00 INFO - 'SHLVL': '1', 15:33:00 INFO - 'TERM': 'linux', 15:33:00 INFO - 'TMOUT': '86400', 15:33:00 INFO - 'USER': 'cltbld', 15:33:00 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1484177542.807542-714196871', 15:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:00 INFO - '_': '/tools/buildbot/bin/python'} 15:33:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:01 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)) 15:33:01 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)) 15:33:01 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)) 15:33:01 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)) 15:33:01 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)) 15:33:01 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)) 15:33:01 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)) 15:33:01 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)) 15:33:01 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)) 15:33:01 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)) 15:33:01 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)) 15:33:01 INFO - Cleaning up... 15:33:01 INFO - Return code: 0 15:33:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:33:01 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')]} 15:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:01 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')]} 15:33:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:01 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 0x7fba93e6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ecca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e9f60>, '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 0x21ead40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21eb1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1484177542.807542-714196871', '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 15:33:01 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 15:33:01 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 15:33:01 INFO - Using env: {'DISPLAY': ':0', 15:33:01 INFO - 'HOME': '/home/cltbld', 15:33:01 INFO - 'LANG': 'en_US.UTF-8', 15:33:01 INFO - 'LANGUAGE': 'en_US:en', 15:33:01 INFO - 'LOGNAME': 'cltbld', 15:33:01 INFO - 'MAIL': '/var/mail/cltbld', 15:33:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:01 INFO - 'MOZ_NO_REMOTE': '1', 15:33:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:01 INFO - 'NO_EM_RESTART': '1', 15:33:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:01 INFO - 'PWD': '/builds/slave/test', 15:33:01 INFO - 'SHELL': '/bin/bash', 15:33:01 INFO - 'SHLVL': '1', 15:33:01 INFO - 'TERM': 'linux', 15:33:01 INFO - 'TMOUT': '86400', 15:33:01 INFO - 'USER': 'cltbld', 15:33:01 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1484177542.807542-714196871', 15:33:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:01 INFO - '_': '/tools/buildbot/bin/python'} 15:33:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:33:01 INFO - Cleaning up... 15:33:01 INFO - Return code: 0 15:33:01 INFO - Running post-action listener: _resource_record_post_action 15:33:01 INFO - Running post-action listener: _start_resource_monitoring 15:33:01 INFO - Starting resource monitoring. 15:33:01 INFO - [mozharness: 2017-01-11 23:33:01.354960Z] Finished create-virtualenv step (success) 15:33:01 INFO - [mozharness: 2017-01-11 23:33:01.355461Z] Running install step. 15:33:01 INFO - Running pre-action listener: _resource_record_pre_action 15:33:01 INFO - Running main action method: install 15:33:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:33:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:33:01 INFO - Reading from file tmpfile_stdout 15:33:01 INFO - Detecting whether we're running mozinstall >=1.0... 15:33:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:33:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:33:01 INFO - Reading from file tmpfile_stdout 15:33:01 INFO - Output received: 15:33:01 INFO - Usage: mozinstall [options] installer 15:33:01 INFO - Options: 15:33:01 INFO - -h, --help show this help message and exit 15:33:01 INFO - -d DEST, --destination=DEST 15:33:01 INFO - Directory to install application into. [default: 15:33:01 INFO - "/builds/slave/test"] 15:33:01 INFO - --app=APP Application being installed. [default: firefox] 15:33:01 INFO - mkdir: /builds/slave/test/build/application 15:33:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:33:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:33:17 INFO - Reading from file tmpfile_stdout 15:33:17 INFO - Output received: 15:33:17 INFO - /builds/slave/test/build/application/firefox/firefox 15:33:17 INFO - Running post-action listener: _resource_record_post_action 15:33:17 INFO - [mozharness: 2017-01-11 23:33:17.664128Z] Finished install step (success) 15:33:17 INFO - [mozharness: 2017-01-11 23:33:17.664369Z] Running run-tests step. 15:33:17 INFO - Running pre-action listener: _resource_record_pre_action 15:33:17 INFO - Running main action method: run_tests 15:33:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:33:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:33:17 INFO - Python 2.7.3 15:33:17 INFO - Return code: 0 15:33:17 INFO - grabbing minidump binary from tooltool 15:33:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:17 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 0x21e9f60>, '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 0x21ead40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21eb1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:33:17 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 15:33:17 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 15:33:17 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 15:33:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:33:17 INFO - Return code: 0 15:33:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:33:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:33:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:33:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:33:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:33:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NDRFhHCOROiOUFlkRacjyg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:33:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NDRFhHCOROiOUFlkRacjyg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:33:17 INFO - Using env: {'DISPLAY': ':0', 15:33:17 INFO - 'HOME': '/home/cltbld', 15:33:17 INFO - 'LANG': 'en_US.UTF-8', 15:33:17 INFO - 'LANGUAGE': 'en_US:en', 15:33:17 INFO - 'LOGNAME': 'cltbld', 15:33:17 INFO - 'MAIL': '/var/mail/cltbld', 15:33:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:33:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:33:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:17 INFO - 'MOZ_NO_REMOTE': '1', 15:33:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:33:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:17 INFO - 'NO_EM_RESTART': '1', 15:33:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:17 INFO - 'PWD': '/builds/slave/test', 15:33:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:33:17 INFO - 'SHELL': '/bin/bash', 15:33:17 INFO - 'SHLVL': '1', 15:33:17 INFO - 'TERM': 'linux', 15:33:17 INFO - 'TMOUT': '86400', 15:33:17 INFO - 'USER': 'cltbld', 15:33:17 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1484177542.807542-714196871', 15:33:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:17 INFO - '_': '/tools/buildbot/bin/python'} 15:33:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NDRFhHCOROiOUFlkRacjyg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:33:17 INFO - mozversion application_buildid: 20170111134216 15:33:17 INFO - mozversion application_changeset: 4c681a167a5e3ce19021604e1b3661d2418b4966 15:33:17 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:33:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:33:17 INFO - mozversion application_name: Firefox 15:33:17 INFO - mozversion application_remotingname: firefox-dev 15:33:17 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:33:17 INFO - mozversion application_vendor: Mozilla 15:33:17 INFO - mozversion application_version: 52.0a2 15:33:17 INFO - mozversion platform_buildid: 20170111134216 15:33:17 INFO - mozversion platform_changeset: 4c681a167a5e3ce19021604e1b3661d2418b4966 15:33:17 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:33:17 INFO - mozversion platform_version: 52.0a2 15:33:17 INFO - using testdate: 1484177597 15:33:17 INFO - actual date: 1484177597 15:33:17 INFO - starting webserver on 'localhost:56701' 15:33:17 INFO - SUITE-START | Running 2 tests 15:33:17 INFO - TEST-START | dromaeo_css 15:33:17 INFO - operating with platform_type : linux_ 15:33:17 INFO - Initialising browser for dromaeo_css test... 15:33:17 INFO - TEST-INFO | started process 19420 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBRmZH6/profile http://localhost:56701/getInfo.html) 15:33:21 INFO - PROCESS | 19420 | __metrics Screen width/height:1600/1200 15:33:21 INFO - PROCESS | 19420 | colorDepth:24 15:33:21 INFO - PROCESS | 19420 | Browser inner width/height: 1024/697 15:33:21 INFO - PROCESS | 19420 | __metrics 15:33:21 INFO - PROCESS | 19420 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:33:21 INFO - PROCESS | 19420 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:33:22 INFO - PROCESS | 19420 | console.error: PushService: 15:33:22 INFO - PROCESS | 19420 | stateChangeProcessEnqueue: Error transitioning state 15:33:22 INFO - PROCESS | 19420 | UnknownError 15:33:22 INFO - TEST-INFO | 19420: exit 0 15:33:22 INFO - Browser initialized. 15:33:22 INFO - Running cycle 1/1 for dromaeo_css test... 15:33:22 INFO - TEST-INFO | started process 19516 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBRmZH6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:33:34 INFO - PROCESS | 19516 | RSS: Main: 144207872 15:33:34 INFO - PROCESS | 19516 | 15:36:35 INFO - PROCESS | 19516 | Cycle 1(1): loaded http://localhost:56701/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56701/tests/dromaeo/cssquery-ext.html) 15:36:36 INFO - PROCESS | 19516 | RSS: Main: 241922048 15:36:36 INFO - PROCESS | 19516 | 15:39:39 INFO - PROCESS | 19516 | Cycle 1(1): loaded http://localhost:56701/tests/dromaeo/cssquery-ext.html (next: http://localhost:56701/tests/dromaeo/cssquery-jquery.html) 15:39:39 INFO - PROCESS | 19516 | RSS: Main: 231088128 15:39:39 INFO - PROCESS | 19516 | 15:42:41 INFO - PROCESS | 19516 | Cycle 1(1): loaded http://localhost:56701/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56701/tests/dromaeo/cssquery-mootools.html) 15:42:42 INFO - PROCESS | 19516 | RSS: Main: 211165184 15:42:42 INFO - PROCESS | 19516 | 15:45:44 INFO - PROCESS | 19516 | Cycle 1(1): loaded http://localhost:56701/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56701/tests/dromaeo/cssquery-prototype.html) 15:45:44 INFO - PROCESS | 19516 | RSS: Main: 236163072 15:45:44 INFO - PROCESS | 19516 | 15:48:47 INFO - PROCESS | 19516 | Cycle 1(1): loaded http://localhost:56701/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56701/tests/dromaeo/cssquery-yui.html) 15:48:48 INFO - PROCESS | 19516 | RSS: Main: 176865280 15:48:48 INFO - PROCESS | 19516 | 15:51:50 INFO - PROCESS | 19516 | Cycle 1(1): loaded http://localhost:56701/tests/dromaeo/cssquery-yui.html (next: http://localhost:56701/tests/dromaeo/cssquery-dojo.html) 15:51:50 INFO - PROCESS | 19516 | RSS: Main: 264450048 15:51:50 INFO - PROCESS | 19516 | 15:51:50 INFO - PROCESS | 19516 | __start_tp_report 15:51:50 INFO - PROCESS | 19516 | _x_x_mozilla_page_load 15:51:50 INFO - PROCESS | 19516 | _x_x_mozilla_page_load_details 15:51:50 INFO - PROCESS | 19516 | |i|pagename|runs| 15:51:50 INFO - PROCESS | 19516 | |0;dojo.html;3215.6945090216427;3234.1267857678426;3256.1045712429077;3274.3287626036663;3298.901032969012;5485.862853428666;5580.91628625571;5581.107022876341;5581.162825576155;5583.469570390806;5520.558355331574;5576.302962129734;5585.022621041312;5598.748056337465;5612.831615051545;5020.447750747415;5038.470960549144;5064.898702025976;5104.923426148611;5109.565686916617;4969;5071.543561079502;5123.385193776752;5134.306868572732;5138.306328645641;4894.5594896459315;4934.654574179809;4946.530079642446;4957.950420495803;5051.494850514938;5075.822346217883;5088.109580823341;5100.132977393852;5192.8961420771375;5195.671435255675;5015.974920125376;5104.923426148611;5152.793888244466;5168.664036837594;5195.350581177353;5338.0925242708445;5379.246905433203;5432.837014889559;5445.809396671137;5468.234447177399;5860.296764388258;5875.764969401219;5876.823695289148;5971.343152253248;5979.910301345483;5956.52347812174;5992.310884248323;5997.760089596411;6009.248843894513;6017.097435384683;5362.249285100089;5406.378266499363;5482.17767334899;5513.807016754475;5516.393196748354;6044.455998960027;6080.0575910733905;6085.513158947362;6086.482648974887;6092.329843717188;5813.7383817728305;5822.737976791054;5831.475167234969;5834.3290521589715;5845.561582881301;5629.662220266797;5641.971790141023;5746.9425305747245;5785.218995435563;5793.739281732248;5829.125631155276;5831.533477321804;5840.678762668094;5861.41385861419;5876.588638795329;5812.215350927655;5858.091995740667;5868.207791948118;5872.412758724179;5877.5591830612875;4462.553744625511;4513.119941611354;4538.568835960645;4585.6102231310715;4601.7699115044115;4116.938245926313;4139.068709540329;4157.937630935538;4170.895727606834;4191.161767646483;5696.3449203341315;5702.030654788696;5704.144378343199;5705.400932902068;5731.226284451629;5703.657780533182;5736.799212027559;5910.911336329958;5914.408559144051;5919.348871624118;5572.192032155314;5580.414056524088;5587.357453892773;5682.460166284196;5710.114932185518;5102.285680004802;5104.132297509433;5112.156494178419;5112.182050871843;5119.10415677255;5992.850178745566;6052.092186172109;6170.228721409824;6224.626522408579;6232.501399887998;5881.3236477803885;5885.73514191871;5902.586818922806;5970.611910225822;5997.940020599738;6234.251889773256;6265.4361107500545;6267.185265915402;6270.184875966278;6271;5631.070873305859;5816.738246778989;5828.300603927556;5832.9708351457975;5860.882782344414;5769.192313076257;5990.221271234712;6015.218021657157;6045;6053.878922421615;5848.064309710426;5862.325832529314;5870.9412905872105;5872.119182122716;5875.089361149029;5705.172749951317;5838.2702162229725;5843.620164689281;5844.12338149264;5845.532357411312;5575.637583557056;5634.774609015593;5718.370979192202;5746.971265143815;5751.654900705971;5894;5897.970510147422;5900.881982360414;5901.704914754331;5915.112733090071;5496.1755736639825;5745.569082318926;5747.109198074305;5754.482096611325;5755.913661295168 15:51:50 INFO - PROCESS | 19516 | |1;ext.html;569.8461415417837;589.69041253342;621.5431657731566;647.6017249391625;664.1830548425434;34710;46017;46616;46751.53248467515;46847.06305873881;46541;46733.7663311683;46946.53053469464;47039.29441058387;47112.76443617777;8373.706920257791;8914.509701966406;9070.138336857988;9071.773205669879;9077.63689452421;8672.783180420476;10545.103666188383;10868.836967445495;10872.891271087306;11157.330560166376;10973.725656858562;11018.50416731249;11031.503582338773;11042.227044106916;11047.447627618627;10812.405317707522;10864.185186110994;10868.07621352186;10872.130229581615;10945.343279403261;10729.570817167303;10774.515146818412;10806.837897431546;10820;10824.945875270652;45160;45302.32046519305;45528.08943821105;45528.77235613834;45583.31625025594;3586.4261718124976;3669.3945498992634;3906.1915380816076;4066.207089617526;4353.107612939371;33374.833125834455;33941.490877636854;34097.82951085229;34423.48364774505;35108.824455877555;4380.693351465398;4394.934075988863;4494.415725955638;4507.594316511497;4569.492067617678;247274;247416;248168;361610;362928;66473.33526664769;66927.33072669308;66987;67098.3290167092;67121.32878671249;40940.79529602393;42466;42552.57447425548;44390.33414498785;44480.3327950081;19163.32928347501;19279.80720192808;19349.12928918174;19349.12928918202;19353.225870965285;12545.874541254652;12788;14554.345054472575;14670.63323416923;14755.77866332006;20446.284380046625;21341.679874801892;21371.35885923425;21428.78571214299;21481.46296342604;7316.487845850739;7425.480216384909;7444.8883266751045;7467.327940485382;7510.4742668013805;1001.5192707500295;1040.8282633365409;1059.210887888528;1159.3623507071077;1212.1999480342931;34727.305453891284;34966.426510807076;35538;35568.466473002925;35621.64378356235;1145.2098052344022;1201.4473342262656;1214.860291066521;1249.1318533619228;1259.817326487654;18500.259989600265;18713.81286187148;18805;18908.43274701761;19008.334708285143;421014;542014;543405;543574;543897;65900.34099658942;66421.33578664248;66767;66829.33170668328;66860.66569667218;1220.87791220879;1362.3869258833367;1364.195124876308;1419.8083258760141;1453.0772959171002;27902;36799.60802547826;36878.44682329821;38786.2242755149;39515.2096958065;62332;63187;63229;63304;63454;382329;383573;383791;384083;386180;28753.281167970967;30018.69981300159;32260;32327.676723232467;32416.675833241366;50347;51326.74336628293;51369.486305137965;51667;52433.47566524438;43476.78261608672;43486.782566086964;43809.56190438055;44420.11159776851;45509.08981820411;43690.135110308365;45131;45443.54556454393;45534.54465455303;46410.53589464062;46166;46454.76772616115;46776.29835552401;47406.28890566575;47700.284495731896;37527.43708844424;40766;40881.38677919893;40901.1041670825;41186.79406602948;30529.847350763994;30585.08244752661;30608.693913061474;30735.385292294475;31153.221169470038 15:51:50 INFO - PROCESS | 19516 | |2;jquery.html;424.18556371766203;427.5661108624646;427.69633560172275;432.2155288152004;450.2413433364779;18520.536986575342;19036.524086897836;20187.697184542245;20380.38858834237;20402.183912643493;17332.046737429435;19048.61902761944;19669.114889829958;19766.505837354074;20111.49721256969;5235.55497782689;5478.424765399635;5487.094629386146;5488.067028605146;5489.4236105208975;5319.069162896478;5397.595180361469;5458.727063646822;5475.890482190353;5801.129830525434;5821.825345239649;5827.708614569276;5828.795992140276;5828.970855145718;5834.941650583503;5644.491995720385;5831.912521312183;5834.329052159013;5842.24050873388;5888.941110588882;5355.169948657965;5363.383210930754;5364.088105022156;5372.274742909696;5374.328208973879;15068.924655376763;15151.090934543963;15172.24138793067;15215.543533694006;20762.48093797652;2325.6278995360663;2465.963010554843;2525.229804909502;2727.7408646178583;2747.7527022568065;10735.463226838627;11023.559057637685;11171.944140279247;11181.44092795365;11234.382108984002;2019.3840878532042;2201.4496375906024;2317.165820304689;2387.3288697911357;2393.868337241451;89227;97658;104734;106138.46930765297;109927;17611.911940440215;19008.809911900706;19012.904935475235;19060.809391905903;19264.61470770577;35838.64161358353;35923.28153436917;36070;36327.4550881737;36396.818015909754;10640.84038739404;10666.78666426667;10779.568817247222;10833.133349332034;11198.38408887519;8826.382153249338;8844.204021638083;9077;9237.530169934647;9455.810883782286;9300.767480812898;9348.532573371303;9505.952470237604;9626.229901607994;9762.267829912644;3383.052745231339;3419.076849250688;3465.480177973274;3561.2521370511963;3737.4020156774786;949.924006079512;999.7550600102876;1033.5917312661607;1073.7237057438124;1118.6308518188978;19626.411207663794;21473.46316342104;21525.677114842976;21534.676979845313;21582.35252942414;1013.2299452416216;1034.2656713733184;1043.9269251152498;1047.1151876664208;1072.710368200597;11421;12003.039756819433;12056.517739290506;12142.75714485723;12151.756964860653;513155;516356;520536;527453;529500;56849.715751420976;80129.59935200404;100702.4964875171;101738;105308;997.4563862694848;1000.2548101664306;1020.5305559442592;1021.3922715983978;1040.6461802987171;18404.987725675215;18561.35035273759;19169.80830191736;19209.71185432192;19399.90300048491;43278;43319.35020974751;43358.56641433672;43941.560584393745;44412;61566;62028;62854.68572657107;63635.36364636479;65137.34862651502;8862.42394244372;8885.777855553662;8922.330825188006;9164.633414663605;11521.596744113916;13495.797563036758;13523.377194736695;13717.931410342884;14092.436302548193;14299.499517516837;12363.443645035815;12382.380880956096;12470.314132722424;12577.622671319876;12647.747045058863;12540.749185016066;12725.745485090061;12959.546415875398;12972;13074.477020919438;11714.765704685688;12750.872491275339;12859.614211573667;12986.415611297703;13142.540011099565;12874.16317939331;12938.417771200131;13072.084954053125;13091.803622945854;13204.471821127046;12579.433925473193;12618.305993170097;12741.044421668597;12818.61544153677;12838.55065072718 15:51:50 INFO - PROCESS | 19516 | |3;mootools.html;1344.3950222399922;1501.5270189890186;1524.4054818620737;1685.401682402747;1835.85313174946;7706.576138312391;8213;8432.156784321573;8808.29533637309;8824.470531768098;8639.438436501623;8714.651413943435;8715.564221788902;8717.389782715196;8730.301575873931;2502.737212592679;2527.9620805687928;2531.746825317472;2537.124691981273;2543.300592337104;2460.360306320352;2482.5283196192668;2484.8881800319027;2497.8126640501946;2506.9972011195578;2429.6355546667965;2444.352246654629;2447.6328550717444;2451.399407145243;2451.938701532467;2419.41933935855;2430.7083150021936;2432.6351047342864;2435.427674496492;2451.84063035903;2395.0539536883007;2411.023535468138;2436.2691192642314;2464.051340234005;2465.161844972718;8526.914730852674;8798.252148567379;8867.955660221658;8875.955620221923;8876.201141897196;5401.3248343957;5477.096279113942;5539.501444869981;5620.297462817148;5621.971890140564;3508.28080243552;3582.7850328980344;3665.395209790408;3669.889903302905;3671.284099600579;1162.953481860733;1177.3995262416145;1182.4560702077056;1206.7465832175253;2155.622766015941;11917.702057448547;12355;12378.257304561756;12380.319082450462;12410.875891241063;4598.2412901871485;4620.699654522513;4632.490426053131;4658.161530924466;4671.532846715301;9474.95262523683;9476.763080922894;9482.099200575934;9485.857712134324;9486.146246837818;5324.707141107277;5325.920111198335;5340.465953404629;5342.385625653022;5342.8931421372135;4116.485439320085;4335.82656693735;4342.392065110887;4994.026164897883;5050.191969284971;3845.115623406632;3858.498395208605;3955.2287303976022;3959.584243654375;3959.7228194026143;1208.112037652325;1230.0958795285458;1237.059834525767;1243.104964425612;1247.9563215287421;866.4281574161023;905.6513242401722;1011.1152741351318;1023.7389465686202;1032.3238278927315;5912.379200183918;5962.522998160223;6074.817755467343;6156.138140660311;6292.968535157295;484.9975750121227;980.8234517786724;1056.799208150449;1077.4612693653173;1091.7434402915308;3911.2177564486647;4064.7561146330722;4108.322126849036;4135.338345864648;4138.52406973202;10693.358398496115;10826;10942.562297508011;10959.397233152253;10966.177536684621;10630.255882088335;10636.202284828514;10675.466226688635;10853.728656783644;10888.836667449994;8253.215944485264;8291.253787159185;8311.293540049042;8484.575771211415;8512.829743405096;5868.2077919480325;5895.380984996514;5917.230760001173;5931.169636251015;6001.939980600138;9950.402975821475;9973.60105595768;10121.797564048531;10244.282900196915;10265.076143147153;9907.900920990698;10214.744631384276;10223;10316.123129534073;10321.174306055347;7226.096737907762;7361.705531778669;7366.594837284001;7366.77899663011;7368.189499155196;8413.747587572383;8421.368397370345;8472.618732156945;8477.067522572635;8483.533405662747;7694.269044440769;7714.652840622298;7728.497647652885;7799.103103143211;7941.563214023284;7602.885956710765;7617.581033043236;7677.654505547375;7818.648160832662;7914.722984695508;6857.348551887562;6858.828529286808;6933.4106600939485;6987.161540615159;6992.615406152507;5227.4249832517635;5229.529342359054;5333.813316533902;5405.378381486022;5524.1989911463415;5375.354957405137;5450.890982180414;5512.779488820563;5516.14499752539;5557.888842223214 15:51:50 INFO - PROCESS | 19516 | |4;prototype.html;341.6429830826786;347.52042181789136;357.1107941226346;360.36755494107837;365.5138665574784;5337.973310133449;5422.457754224575;5422.728863556821;5444.1561557958485;5444.183372494128;5334.253204551366;5348.91976620351;5353.411124776271;5356.54469370103;5363.8122665706705;3964.1477082427273;4313.396124542566;4319.827206911736;4321.459817522802;4355.950834415921;3801.923961520768;4102.589741025903;4257.489101307848;4267.359896015607;4293.527711951683;4205.621494065534;4225.746455212697;4227.492700875884;4237.533871274158;4250.128723611652;4218.514870789868;4236.216299984513;4257.14857028594;4260.444937597786;4269.423627810237;3532.982335088308;3642.0530662028063;3656.579493358271;3793;3822.445745366934;5203.635745497817;5203.661761985497;5225.529702326809;5233.528982391603;5257.316548848664;4821.264344835857;4830.637702172316;4831.130396528623;4866.975665121687;4897.142999975025;5319.388270348921;5476.58925580579;5493.670379777186;5538;5555.388907220203;4130.421740956269;4133.503979522447;4144;4148.377743338493;4162.105147393295;5555.972220138873;5613.691246981414;5855.648661080306;5862.384449632812;5866.354700982888;4155.709100362946;4165.291900376943;4189.874303770892;4193.790310484464;4206.20082184384;4254.851300093433;4257.552432173076;4296.183725092223;4299.527052024275;4301.870943871689;4530.97734511332;4792.832250871203;4836.177849765549;4853.417589889236;4873.439554451284;5612.494875461228;5651.265335506358;5671.241915006279;5693.3168019837885;5707.800226992035;1414.7524183267888;1425.1947649577955;1426.2013272567397;1437.2669938331526;1441.67562298482;950.3632566180676;991.7074463033423;1000.8598796168542;1002.283367392318;1005.8491226315965;5316.989771943318;5325.281087053276;5337.706426146521;5365.222042803772;5365.275687782178;5515.034868898007;5560.332760068818;5564.638298510584;5588.720563971785;5616.326040875121;5117.488251174853;5317.494837990384;5363.919541206885;5373.274607927958;5410.296661434067;2955.9113226603235;2978.434097521464;2982.925426864346;2990.5065664165168;2992.1921081307923;5853.239078919798;5865.20819689345;5874.089516125007;5893.852653683693;5897.882042359214;5577.2191893135;5867.471927526458;5879.706014699248;5883.323417807007;5904.3172695781495;6110.4195101466175;6112.908306375408;6121.296050954197;6133.9079913802225;6162.691865406801;5603.327600687943;5784.363719990882;5795.246617939641;5811.418858114154;5835.649861008353;5712.485876271156;5722.914156287576;5727.198192253171;5738.97407721882;5740.339860915881;5825;5919.467247947706;5920.230370051866;5954.910676339771;6028.779854102234;4043.1913617276073;4154.27894728953;4162.791860407028;4181.916361672688;4191.512013235258;5582.692951887685;5781.525710943851;5781.5663825214115;5782.942170578241;5788.189653448437;5603.159526071122;5624.493795558419;5630.915536266877;5634.2393776841245;5646.604737668324;5612.579056570692;5624.550035997192;5629;5630.690312032878;5646.85882852932;5343.893122137458;5535.750891209825;5578.525825304894;5593.881223755184;5603.327600687943;5607.607467477237;5639.8590035249445;5641.435856414326;5642.294713160855;5642.887142257214;5505.256790333254;5508;5508.383517828999;5518.779248830002;5533.474319939599 15:51:50 INFO - PROCESS | 19516 | |5;yui.html;774.372758065967;784.9293563579276;804.6861723927666;826.1696994520507;837.6272558711372;13147.145435546694;13554.322283885804;13780.793288100662;13904.582862514128;13988.440462381517;12986.41561129749;13073.73852522949;13149;13230.867691323085;13231.735365292689;738.265425901229;753.0210726056132;872.2585802068223;877.7542288159294;879.2350654930219;875.2341701011615;879.4503435352905;879.4811061473729;880.2122100719852;880.6873559886244;902.7382059202823;906.134641417448;906.188960880012;906.6282824042144;908.0601577367426;901.7565257380536;902.0753727429371;902.4810733828075;902.5622573052098;903.2277402820625;659.9835004124888;661.5170925224613;661.6790856434625;661.867626474707;662.1855118204587;12295.815562766566;12767.106302558825;12811.167274127152;12850;13775.586732398044;12610.369481525888;12868.549600764021;12894.032947528973;13084.280364579945;13095.869041309561;11459.197856150073;11470.254433461798;11591.76816463666;11639.243449175861;11821.290722556674;3793.7534060285993;3794.7343685941996;3809.276237514863;3877.8836634901;3931.8623848165175;57676.42323576753;58205.99999999958;62948.37051629471;63754;64481.355186448;11377.658670239905;11407.144464165222;11470.369129697947;11579.942100289445;11666.241694289844;19063.904680476786;19120.426387208405;19189;19450.610987780165;19701.734300555334;8409.453385529921;8420.915790842135;8424.831503369898;8465.915340846635;8660.332920841412;4500.437445319335;4572.6799124061;4620.722756634613;4681.180793361148;4761.119192949246;3475.721942244665;3557.6975957043423;3595.658412450813;3596.2447885944243;3600.1719604491113;615.7198474694003;625.9061140828821;631.9494440444753;640.2732898160622;640.3628389752133;686.6909890549273;736.9447291453055;745.1542499263267;796.3469954637142;812.8740045292989;9219.262459003263;9512.714618561455;9591.856122158173;10286.588536458457;10289.897101028893;622.6170904893548;739.9788292156896;765.5215490318551;793.131520984521;800.543690096651;4708.646851486153;4752.477227504972;4859.927101093486;4860.416749990024;4912.263160525949;55629.44370556324;55661.165082523796;55685.721571391885;62464.68767656224;80038.59980700059;46083;60137.39862601405;81259;83709.16290837135;85016.57491712502;66818.33181668218;67552.66223668949;67728.3227167722;67873.66063169751;68700;10054.69835904924;10312.742181445525;10349;10484.108850747773;10502.422366769595;45624.77187614041;45754.31368529541;46090.308645369674;46763.766181168874;47449.28826067681;56401.307960761245;65080.34919650743;66248;67492;68532;12659;12786.104972652198;12892.677683057624;13217.669558261121;13417.66455838612;12329.938350308192;12475.563355282522;14548.345324460637;14862.702745945237;15082.17048062367;12784.488620455078;13344.199348039148;13700.65748356299;14688;14784.33470493852;13161.670958226121;13207.009474289274;13335.933320333335;13833.792493112813;14015.656683341558;13935.233562154179;14361.712765744836;14501.20243386624;14520.564383068524;14695.853041469449;10416.32293900894;10852.511636976196;11037.558497660324;11263.493142808757;11346.319220846775;11828.526858925547;12124.939375303067;12334.444949977093;12363.443645036175;12574.748505029665 15:51:50 INFO - PROCESS | 19516 | __end_tp_report 15:51:50 INFO - PROCESS | 19516 | __start_cc_report 15:51:50 INFO - PROCESS | 19516 | _x_x_mozilla_cycle_collect,1011 15:51:50 INFO - PROCESS | 19516 | __end_cc_report 15:51:50 INFO - PROCESS | 19516 | __startTimestamp1484178710963__endTimestamp 15:51:50 INFO - PROCESS | 19516 | 15:51:50 INFO - PROCESS | 19516 | ------- Summary: start ------- 15:51:50 INFO - PROCESS | 19516 | Number of tests: 6 15:51:50 INFO - PROCESS | 19516 | 15:51:50 INFO - PROCESS | 19516 | [#0] dojo.html Cycles:165 Average:5512.53 Median:5718.37 stddev:610.64 (10.7%) stddev-sans-first:585.33 15:51:50 INFO - PROCESS | 19516 | Values: 3215.7 3234.1 3256.1 3274.3 3298.9 5485.9 5580.9 5581.1 5581.2 5583.5 5520.6 5576.3 5585.0 5598.7 5612.8 5020.4 5038.5 5064.9 5104.9 5109.6 4969.0 5071.5 5123.4 5134.3 5138.3 4894.6 4934.7 4946.5 4958.0 5051.5 5075.8 5088.1 5100.1 5192.9 5195.7 5016.0 5104.9 5152.8 5168.7 5195.4 5338.1 5379.2 5432.8 5445.8 5468.2 5860.3 5875.8 5876.8 5971.3 5979.9 5956.5 5992.3 5997.8 6009.2 6017.1 5362.2 5406.4 5482.2 5513.8 5516.4 6044.5 6080.1 6085.5 6086.5 6092.3 5813.7 5822.7 5831.5 5834.3 5845.6 5629.7 5642.0 5746.9 5785.2 5793.7 5829.1 5831.5 5840.7 5861.4 5876.6 5812.2 5858.1 5868.2 5872.4 5877.6 4462.6 4513.1 4538.6 4585.6 4601.8 4116.9 4139.1 4157.9 4170.9 4191.2 5696.3 5702.0 5704.1 5705.4 5731.2 5703.7 5736.8 5910.9 5914.4 5919.3 5572.2 5580.4 5587.4 5682.5 5710.1 5102.3 5104.1 5112.2 5112.2 5119.1 5992.9 6052.1 6170.2 6224.6 6232.5 5881.3 5885.7 5902.6 5970.6 5997.9 6234.3 6265.4 6267.2 6270.2 6271.0 5631.1 5816.7 5828.3 5833.0 5860.9 5769.2 5990.2 6015.2 6045.0 6053.9 5848.1 5862.3 5870.9 5872.1 5875.1 5705.2 5838.3 5843.6 5844.1 5845.5 5575.6 5634.8 5718.4 5747.0 5751.7 5894.0 5898.0 5900.9 5901.7 5915.1 5496.2 5745.6 5747.1 5754.5 5755.9 15:51:50 INFO - PROCESS | 19516 | 15:51:50 INFO - PROCESS | 19516 | [#1] ext.html Cycles:180 Average:58690.43 Median:212483.11 stddev:108744.07 (51.2%) stddev-sans-first:108961.57 15:51:50 INFO - PROCESS | 19516 | Values: 569.8 589.7 621.5 647.6 664.2 34710.0 46017.0 46616.0 46751.5 46847.1 46541.0 46733.8 46946.5 47039.3 47112.8 8373.7 8914.5 9070.1 9071.8 9077.6 8672.8 10545.1 10868.8 10872.9 11157.3 10973.7 11018.5 11031.5 11042.2 11047.4 10812.4 10864.2 10868.1 10872.1 10945.3 10729.6 10774.5 10806.8 10820.0 10824.9 45160.0 45302.3 45528.1 45528.8 45583.3 3586.4 3669.4 3906.2 4066.2 4353.1 33374.8 33941.5 34097.8 34423.5 35108.8 4380.7 4394.9 4494.4 4507.6 4569.5 247274.0 247416.0 248168.0 361610.0 362928.0 66473.3 66927.3 66987.0 67098.3 67121.3 40940.8 42466.0 42552.6 44390.3 44480.3 19163.3 19279.8 19349.1 19349.1 19353.2 12545.9 12788.0 14554.3 14670.6 14755.8 20446.3 21341.7 21371.4 21428.8 21481.5 7316.5 7425.5 7444.9 7467.3 7510.5 1001.5 1040.8 1059.2 1159.4 1212.2 34727.3 34966.4 35538.0 35568.5 35621.6 1145.2 1201.4 1214.9 1249.1 1259.8 18500.3 18713.8 18805.0 18908.4 19008.3 421014.0 542014.0 543405.0 543574.0 543897.0 65900.3 66421.3 66767.0 66829.3 66860.7 1220.9 1362.4 1364.2 1419.8 1453.1 27902.0 36799.6 36878.4 38786.2 39515.2 62332.0 63187.0 63229.0 63304.0 63454.0 382329.0 383573.0 383791.0 384083.0 386180.0 28753.3 30018.7 32260.0 32327.7 32416.7 50347.0 51326.7 51369.5 51667.0 52433.5 43476.8 43486.8 43809.6 44420.1 45509.1 43690.1 45131.0 45443.5 45534.5 46410.5 46166.0 46454.8 46776.3 47406.3 47700.3 37527.4 40766.0 40881.4 40901.1 41186.8 30529.8 30585.1 30608.7 30735.4 31153.2 15:51:50 INFO - PROCESS | 19516 | 15:51:50 INFO - PROCESS | 19516 | [#2] jquery.html Cycles:180 Average:31891.00 Median:21117.97 stddev:86053.33 (407.5%) stddev-sans-first:86262.29 15:51:50 INFO - PROCESS | 19516 | Values: 424.2 427.6 427.7 432.2 450.2 18520.5 19036.5 20187.7 20380.4 20402.2 17332.0 19048.6 19669.1 19766.5 20111.5 5235.6 5478.4 5487.1 5488.1 5489.4 5319.1 5397.6 5458.7 5475.9 5801.1 5821.8 5827.7 5828.8 5829.0 5834.9 5644.5 5831.9 5834.3 5842.2 5888.9 5355.2 5363.4 5364.1 5372.3 5374.3 15068.9 15151.1 15172.2 15215.5 20762.5 2325.6 2466.0 2525.2 2727.7 2747.8 10735.5 11023.6 11171.9 11181.4 11234.4 2019.4 2201.4 2317.2 2387.3 2393.9 89227.0 97658.0 104734.0 106138.5 109927.0 17611.9 19008.8 19012.9 19060.8 19264.6 35838.6 35923.3 36070.0 36327.5 36396.8 10640.8 10666.8 10779.6 10833.1 11198.4 8826.4 8844.2 9077.0 9237.5 9455.8 9300.8 9348.5 9506.0 9626.2 9762.3 3383.1 3419.1 3465.5 3561.3 3737.4 949.9 999.8 1033.6 1073.7 1118.6 19626.4 21473.5 21525.7 21534.7 21582.4 1013.2 1034.3 1043.9 1047.1 1072.7 11421.0 12003.0 12056.5 12142.8 12151.8 513155.0 516356.0 520536.0 527453.0 529500.0 56849.7 80129.6 100702.5 101738.0 105308.0 997.5 1000.3 1020.5 1021.4 1040.6 18405.0 18561.4 19169.8 19209.7 19399.9 43278.0 43319.4 43358.6 43941.6 44412.0 61566.0 62028.0 62854.7 63635.4 65137.3 8862.4 8885.8 8922.3 9164.6 11521.6 13495.8 13523.4 13717.9 14092.4 14299.5 12363.4 12382.4 12470.3 12577.6 12647.7 12540.7 12725.7 12959.5 12972.0 13074.5 11714.8 12750.9 12859.6 12986.4 13142.5 12874.2 12938.4 13072.1 13091.8 13204.5 12579.4 12618.3 12741.0 12818.6 12838.6 15:51:50 INFO - PROCESS | 19516 | 15:51:50 INFO - PROCESS | 19516 | [#3] mootools.html Cycles:180 Average:5808.38 Median:2578.27 stddev:3211.24 (124.6%) stddev-sans-first:3202.72 15:51:50 INFO - PROCESS | 19516 | Values: 1344.4 1501.5 1524.4 1685.4 1835.9 7706.6 8213.0 8432.2 8808.3 8824.5 8639.4 8714.7 8715.6 8717.4 8730.3 2502.7 2528.0 2531.7 2537.1 2543.3 2460.4 2482.5 2484.9 2497.8 2507.0 2429.6 2444.4 2447.6 2451.4 2451.9 2419.4 2430.7 2432.6 2435.4 2451.8 2395.1 2411.0 2436.3 2464.1 2465.2 8526.9 8798.3 8868.0 8876.0 8876.2 5401.3 5477.1 5539.5 5620.3 5622.0 3508.3 3582.8 3665.4 3669.9 3671.3 1163.0 1177.4 1182.5 1206.7 2155.6 11917.7 12355.0 12378.3 12380.3 12410.9 4598.2 4620.7 4632.5 4658.2 4671.5 9475.0 9476.8 9482.1 9485.9 9486.1 5324.7 5325.9 5340.5 5342.4 5342.9 4116.5 4335.8 4342.4 4994.0 5050.2 3845.1 3858.5 3955.2 3959.6 3959.7 1208.1 1230.1 1237.1 1243.1 1248.0 866.4 905.7 1011.1 1023.7 1032.3 5912.4 5962.5 6074.8 6156.1 6293.0 485.0 980.8 1056.8 1077.5 1091.7 3911.2 4064.8 4108.3 4135.3 4138.5 10693.4 10826.0 10942.6 10959.4 10966.2 10630.3 10636.2 10675.5 10853.7 10888.8 8253.2 8291.3 8311.3 8484.6 8512.8 5868.2 5895.4 5917.2 5931.2 6001.9 9950.4 9973.6 10121.8 10244.3 10265.1 9907.9 10214.7 10223.0 10316.1 10321.2 7226.1 7361.7 7366.6 7366.8 7368.2 8413.7 8421.4 8472.6 8477.1 8483.5 7694.3 7714.7 7728.5 7799.1 7941.6 7602.9 7617.6 7677.7 7818.6 7914.7 6857.3 6858.8 6933.4 6987.2 6992.6 5227.4 5229.5 5333.8 5405.4 5524.2 5375.4 5450.9 5512.8 5516.1 5557.9 15:51:50 INFO - PROCESS | 19516 | 15:51:50 INFO - PROCESS | 19516 | [#4] prototype.html Cycles:180 Average:4742.96 Median:5363.87 stddev:1381.06 (25.7%) stddev-sans-first:1344.85 15:51:50 INFO - PROCESS | 19516 | Values: 341.6 347.5 357.1 360.4 365.5 5338.0 5422.5 5422.7 5444.2 5444.2 5334.3 5348.9 5353.4 5356.5 5363.8 3964.1 4313.4 4319.8 4321.5 4356.0 3801.9 4102.6 4257.5 4267.4 4293.5 4205.6 4225.7 4227.5 4237.5 4250.1 4218.5 4236.2 4257.1 4260.4 4269.4 3533.0 3642.1 3656.6 3793.0 3822.4 5203.6 5203.7 5225.5 5233.5 5257.3 4821.3 4830.6 4831.1 4867.0 4897.1 5319.4 5476.6 5493.7 5538.0 5555.4 4130.4 4133.5 4144.0 4148.4 4162.1 5556.0 5613.7 5855.6 5862.4 5866.4 4155.7 4165.3 4189.9 4193.8 4206.2 4254.9 4257.6 4296.2 4299.5 4301.9 4531.0 4792.8 4836.2 4853.4 4873.4 5612.5 5651.3 5671.2 5693.3 5707.8 1414.8 1425.2 1426.2 1437.3 1441.7 950.4 991.7 1000.9 1002.3 1005.8 5317.0 5325.3 5337.7 5365.2 5365.3 5515.0 5560.3 5564.6 5588.7 5616.3 5117.5 5317.5 5363.9 5373.3 5410.3 2955.9 2978.4 2982.9 2990.5 2992.2 5853.2 5865.2 5874.1 5893.9 5897.9 5577.2 5867.5 5879.7 5883.3 5904.3 6110.4 6112.9 6121.3 6133.9 6162.7 5603.3 5784.4 5795.2 5811.4 5835.6 5712.5 5722.9 5727.2 5739.0 5740.3 5825.0 5919.5 5920.2 5954.9 6028.8 4043.2 4154.3 4162.8 4181.9 4191.5 5582.7 5781.5 5781.6 5782.9 5788.2 5603.2 5624.5 5630.9 5634.2 5646.6 5612.6 5624.6 5629.0 5630.7 5646.9 5343.9 5535.8 5578.5 5593.9 5603.3 5607.6 5639.9 5641.4 5642.3 5642.9 5505.3 5508.0 5508.4 5518.8 5533.5 15:51:50 INFO - PROCESS | 19516 | 15:51:50 INFO - PROCESS | 19516 | [#5] yui.html Cycles:180 Average:17022.48 Median:45918.66 stddev:21424.61 (46.7%) stddev-sans-first:21449.97 15:51:50 INFO - PROCESS | 19516 | Values: 774.4 784.9 804.7 826.2 837.6 13147.1 13554.3 13780.8 13904.6 13988.4 12986.4 13073.7 13149.0 13230.9 13231.7 738.3 753.0 872.3 877.8 879.2 875.2 879.5 879.5 880.2 880.7 902.7 906.1 906.2 906.6 908.1 901.8 902.1 902.5 902.6 903.2 660.0 661.5 661.7 661.9 662.2 12295.8 12767.1 12811.2 12850.0 13775.6 12610.4 12868.5 12894.0 13084.3 13095.9 11459.2 11470.3 11591.8 11639.2 11821.3 3793.8 3794.7 3809.3 3877.9 3931.9 57676.4 58206.0 62948.4 63754.0 64481.4 11377.7 11407.1 11470.4 11579.9 11666.2 19063.9 19120.4 19189.0 19450.6 19701.7 8409.5 8420.9 8424.8 8465.9 8660.3 4500.4 4572.7 4620.7 4681.2 4761.1 3475.7 3557.7 3595.7 3596.2 3600.2 615.7 625.9 631.9 640.3 640.4 686.7 736.9 745.2 796.3 812.9 9219.3 9512.7 9591.9 10286.6 10289.9 622.6 740.0 765.5 793.1 800.5 4708.6 4752.5 4859.9 4860.4 4912.3 55629.4 55661.2 55685.7 62464.7 80038.6 46083.0 60137.4 81259.0 83709.2 85016.6 66818.3 67552.7 67728.3 67873.7 68700.0 10054.7 10312.7 10349.0 10484.1 10502.4 45624.8 45754.3 46090.3 46763.8 47449.3 56401.3 65080.3 66248.0 67492.0 68532.0 12659.0 12786.1 12892.7 13217.7 13417.7 12329.9 12475.6 14548.3 14862.7 15082.2 12784.5 13344.2 13700.7 14688.0 14784.3 13161.7 13207.0 13335.9 13833.8 14015.7 13935.2 14361.7 14501.2 14520.6 14695.9 10416.3 10852.5 11037.6 11263.5 11346.3 11828.5 12124.9 12334.4 12363.4 12574.7 15:51:50 INFO - PROCESS | 19516 | -------- Summary: end -------- 15:51:50 INFO - PROCESS | 19516 | 15:51:51 INFO - TEST-INFO | 19516: exit 0 15:51:51 INFO - TEST-OK | dromaeo_css | took 1113748ms 15:51:51 INFO - TEST-START | kraken 15:51:51 INFO - operating with platform_type : linux_ 15:51:51 INFO - Initialising browser for kraken test... 15:51:51 INFO - TEST-INFO | started process 19836 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplQkX0v/profile http://localhost:56701/getInfo.html) 15:51:55 INFO - PROCESS | 19836 | __metrics Screen width/height:1600/1200 15:51:55 INFO - PROCESS | 19836 | colorDepth:24 15:51:55 INFO - PROCESS | 19836 | Browser inner width/height: 1024/697 15:51:55 INFO - PROCESS | 19836 | __metrics 15:51:55 INFO - PROCESS | 19836 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:51:55 INFO - PROCESS | 19836 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:51:56 INFO - PROCESS | 19836 | console.error: PushService: 15:51:56 INFO - PROCESS | 19836 | stateChangeProcessEnqueue: Error transitioning state 15:51:56 INFO - PROCESS | 19836 | UnknownError 15:51:56 INFO - TEST-INFO | 19836: exit 0 15:51:56 INFO - Browser initialized. 15:51:56 INFO - Running cycle 1/1 for kraken test... 15:51:56 INFO - TEST-INFO | started process 19932 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplQkX0v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:52:08 INFO - PROCESS | 19932 | RSS: Main: 144420864 15:52:08 INFO - PROCESS | 19932 | 15:52:10 INFO - PROCESS | 19932 | Cycle 1(1): loaded http://localhost:56701/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56701/tests/kraken/driver.html?testName=audio-beat-detection) 15:52:11 INFO - PROCESS | 19932 | RSS: Main: 185995264 15:52:11 INFO - PROCESS | 19932 | 15:52:14 INFO - PROCESS | 19932 | Cycle 1(1): loaded http://localhost:56701/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56701/tests/kraken/driver.html?testName=audio-dft) 15:52:14 INFO - PROCESS | 19932 | RSS: Main: 175538176 15:52:14 INFO - PROCESS | 19932 | 15:52:17 INFO - PROCESS | 19932 | Cycle 1(1): loaded http://localhost:56701/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56701/tests/kraken/driver.html?testName=audio-fft) 15:52:18 INFO - PROCESS | 19932 | RSS: Main: 266788864 15:52:18 INFO - PROCESS | 19932 | 15:52:20 INFO - PROCESS | 19932 | Cycle 1(1): loaded http://localhost:56701/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56701/tests/kraken/driver.html?testName=audio-oscillator) 15:52:20 INFO - PROCESS | 19932 | RSS: Main: 172990464 15:52:20 INFO - PROCESS | 19932 | 15:52:23 INFO - PROCESS | 19932 | Cycle 1(1): loaded http://localhost:56701/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56701/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:52:23 INFO - PROCESS | 19932 | RSS: Main: 176037888 15:52:23 INFO - PROCESS | 19932 | 15:52:26 INFO - PROCESS | 19932 | Cycle 1(1): loaded http://localhost:56701/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56701/tests/kraken/driver.html?testName=imaging-darkroom) 15:52:27 INFO - PROCESS | 19932 | RSS: Main: 214433792 15:52:27 INFO - PROCESS | 19932 | 15:52:30 INFO - PROCESS | 19932 | Cycle 1(1): loaded http://localhost:56701/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56701/tests/kraken/driver.html?testName=imaging-desaturate) 15:52:31 INFO - PROCESS | 19932 | RSS: Main: 212692992 15:52:31 INFO - PROCESS | 19932 | 15:52:33 INFO - PROCESS | 19932 | Cycle 1(1): loaded http://localhost:56701/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56701/tests/kraken/driver.html?testName=json-parse-financial) 15:52:34 INFO - PROCESS | 19932 | RSS: Main: 211771392 15:52:34 INFO - PROCESS | 19932 | 15:52:35 INFO - PROCESS | 19932 | Cycle 1(1): loaded http://localhost:56701/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56701/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:52:36 INFO - PROCESS | 19932 | RSS: Main: 174100480 15:52:36 INFO - PROCESS | 19932 | 15:52:38 INFO - PROCESS | 19932 | Cycle 1(1): loaded http://localhost:56701/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56701/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:52:38 INFO - PROCESS | 19932 | RSS: Main: 180097024 15:52:38 INFO - PROCESS | 19932 | 15:52:40 INFO - PROCESS | 19932 | Cycle 1(1): loaded http://localhost:56701/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56701/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:52:41 INFO - PROCESS | 19932 | RSS: Main: 189972480 15:52:41 INFO - PROCESS | 19932 | 15:52:43 INFO - PROCESS | 19932 | Cycle 1(1): loaded http://localhost:56701/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56701/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:52:44 INFO - PROCESS | 19932 | RSS: Main: 198729728 15:52:44 INFO - PROCESS | 19932 | 15:52:47 INFO - PROCESS | 19932 | Cycle 1(1): loaded http://localhost:56701/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56701/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:52:47 INFO - PROCESS | 19932 | RSS: Main: 195231744 15:52:47 INFO - PROCESS | 19932 | 15:52:49 INFO - PROCESS | 19932 | Cycle 1(1): loaded http://localhost:56701/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56701/tests/kraken/driver.html?testName=ai-astar) 15:52:49 INFO - PROCESS | 19932 | RSS: Main: 247025664 15:52:49 INFO - PROCESS | 19932 | 15:52:49 INFO - PROCESS | 19932 | __start_tp_report 15:52:49 INFO - PROCESS | 19932 | _x_x_mozilla_page_load 15:52:49 INFO - PROCESS | 19932 | _x_x_mozilla_page_load_details 15:52:49 INFO - PROCESS | 19932 | |i|pagename|runs| 15:52:49 INFO - PROCESS | 19932 | |0;ai-astar;103;112;112;113;113;113;112;112;112;111 15:52:49 INFO - PROCESS | 19932 | |1;audio-beat-detection;149;121;123;158;119;119;123;118;156;119 15:52:49 INFO - PROCESS | 19932 | |2;audio-dft;161;162;163;162;161;161;162;162;161;161 15:52:49 INFO - PROCESS | 19932 | |3;audio-fft;75;75;78;107;75;76;76;75;113;75 15:52:49 INFO - PROCESS | 19932 | |4;audio-oscillator;83;82;112;81;82;82;103;81;81;112 15:52:49 INFO - PROCESS | 19932 | |5;imaging-gaussian-blur;116;117;117;117;117;116;116;117;117;117 15:52:49 INFO - PROCESS | 19932 | |6;imaging-darkroom;146;146;147;146;145;146;146;147;146;146 15:52:49 INFO - PROCESS | 19932 | |7;imaging-desaturate;85;84;84;84;84;85;85;85;84;84 15:52:49 INFO - PROCESS | 19932 | |8;json-parse-financial;53;51;51;51;51;50;51;51;54;50 15:52:49 INFO - PROCESS | 19932 | |9;json-stringify-tinderbox;60;59;60;60;60;59;63;59;59;62 15:52:49 INFO - PROCESS | 19932 | |10;stanford-crypto-aes;75;75;80;75;75;77;74;83;74;74 15:52:49 INFO - PROCESS | 19932 | |11;stanford-crypto-ccm;126;131;118;129;119;118;118;127;162;126 15:52:49 INFO - PROCESS | 19932 | |12;stanford-crypto-pbkdf2;156;153;153;159;156;155;154;155;154;153 15:52:49 INFO - PROCESS | 19932 | |13;stanford-crypto-sha256-iterative;63;64;62;62;62;62;65;61;60;61 15:52:49 INFO - PROCESS | 19932 | __end_tp_report 15:52:49 INFO - PROCESS | 19932 | __start_cc_report 15:52:49 INFO - PROCESS | 19932 | _x_x_mozilla_cycle_collect,1567 15:52:49 INFO - PROCESS | 19932 | __end_cc_report 15:52:49 INFO - PROCESS | 19932 | __startTimestamp1484178769644__endTimestamp 15:52:49 INFO - PROCESS | 19932 | 15:52:49 INFO - PROCESS | 19932 | ------- Summary: start ------- 15:52:49 INFO - PROCESS | 19932 | Number of tests: 14 15:52:49 INFO - PROCESS | 19932 | 15:52:49 INFO - PROCESS | 19932 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:2.98 (2.7%) stddev-sans-first:0.67 15:52:49 INFO - PROCESS | 19932 | Values: 103.0 112.0 112.0 113.0 113.0 113.0 112.0 112.0 112.0 111.0 15:52:49 INFO - PROCESS | 19932 | 15:52:49 INFO - PROCESS | 19932 | [#1] audio-beat-detection Cycles:10 Average:130.50 Median:123.00 stddev:16.68 (13.6%) stddev-sans-first:16.30 15:52:49 INFO - PROCESS | 19932 | Values: 149.0 121.0 123.0 158.0 119.0 119.0 123.0 118.0 156.0 119.0 15:52:49 INFO - PROCESS | 19932 | 15:52:49 INFO - PROCESS | 19932 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 15:52:49 INFO - PROCESS | 19932 | Values: 161.0 162.0 163.0 162.0 161.0 161.0 162.0 162.0 161.0 161.0 15:52:49 INFO - PROCESS | 19932 | 15:52:49 INFO - PROCESS | 19932 | [#3] audio-fft Cycles:10 Average:82.50 Median:75.00 stddev:14.59 (19.5%) stddev-sans-first:15.22 15:52:49 INFO - PROCESS | 19932 | Values: 75.0 75.0 78.0 107.0 75.0 76.0 76.0 75.0 113.0 75.0 15:52:49 INFO - PROCESS | 19932 | 15:52:49 INFO - PROCESS | 19932 | [#4] audio-oscillator Cycles:10 Average:89.90 Median:81.50 stddev:13.42 (16.5%) stddev-sans-first:14.00 15:52:49 INFO - PROCESS | 19932 | Values: 83.0 82.0 112.0 81.0 82.0 82.0 103.0 81.0 81.0 112.0 15:52:49 INFO - PROCESS | 19932 | 15:52:49 INFO - PROCESS | 19932 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 15:52:49 INFO - PROCESS | 19932 | Values: 116.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 15:52:49 INFO - PROCESS | 19932 | 15:52:49 INFO - PROCESS | 19932 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 15:52:49 INFO - PROCESS | 19932 | Values: 146.0 146.0 147.0 146.0 145.0 146.0 146.0 147.0 146.0 146.0 15:52:49 INFO - PROCESS | 19932 | 15:52:49 INFO - PROCESS | 19932 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.50 15:52:49 INFO - PROCESS | 19932 | Values: 85.0 84.0 84.0 84.0 84.0 85.0 85.0 85.0 84.0 84.0 15:52:49 INFO - PROCESS | 19932 | 15:52:49 INFO - PROCESS | 19932 | [#8] json-parse-financial Cycles:10 Average:51.30 Median:51.00 stddev:1.25 (2.5%) stddev-sans-first:1.17 15:52:49 INFO - PROCESS | 19932 | Values: 53.0 51.0 51.0 51.0 51.0 50.0 51.0 51.0 54.0 50.0 15:52:49 INFO - PROCESS | 19932 | 15:52:49 INFO - PROCESS | 19932 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:60.00 stddev:1.37 (2.3%) stddev-sans-first:1.45 15:52:49 INFO - PROCESS | 19932 | Values: 60.0 59.0 60.0 60.0 60.0 59.0 63.0 59.0 59.0 62.0 15:52:49 INFO - PROCESS | 19932 | 15:52:49 INFO - PROCESS | 19932 | [#10] stanford-crypto-aes Cycles:10 Average:76.20 Median:75.00 stddev:3.01 (4.0%) stddev-sans-first:3.16 15:52:49 INFO - PROCESS | 19932 | Values: 75.0 75.0 80.0 75.0 75.0 77.0 74.0 83.0 74.0 74.0 15:52:49 INFO - PROCESS | 19932 | 15:52:49 INFO - PROCESS | 19932 | [#11] stanford-crypto-ccm Cycles:10 Average:127.40 Median:126.50 stddev:13.13 (10.4%) stddev-sans-first:13.92 15:52:49 INFO - PROCESS | 19932 | Values: 126.0 131.0 118.0 129.0 119.0 118.0 118.0 127.0 162.0 126.0 15:52:49 INFO - PROCESS | 19932 | 15:52:49 INFO - PROCESS | 19932 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.80 Median:155.00 stddev:1.87 (1.2%) stddev-sans-first:1.94 15:52:49 INFO - PROCESS | 19932 | Values: 156.0 153.0 153.0 159.0 156.0 155.0 154.0 155.0 154.0 153.0 15:52:49 INFO - PROCESS | 19932 | 15:52:49 INFO - PROCESS | 19932 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:62.00 stddev:1.48 (2.4%) stddev-sans-first:1.54 15:52:49 INFO - PROCESS | 19932 | Values: 63.0 64.0 62.0 62.0 62.0 62.0 65.0 61.0 60.0 61.0 15:52:49 INFO - PROCESS | 19932 | -------- Summary: end -------- 15:52:49 INFO - PROCESS | 19932 | 15:52:50 INFO - TEST-INFO | 19932: exit 0 15:52:50 INFO - TEST-OK | kraken | took 59014ms 15:52:50 INFO - SUITE-END | took 1172s 15:52:50 INFO - Completed test suite (00:19:32) 15:52:50 INFO - javascript benchmark 15:52:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3215.6945090216427, 3234.1267857678426, 3256.1045712429077, 3274.3287626036663, 3298.901032969012, 5485.862853428666, 5580.91628625571, 5581.107022876341, 5581.162825576155, 5583.469570390806, 5520.558355331574, 5576.302962129734, 5585.022621041312, 5598.748056337465, 5612.831615051545, 5020.447750747415, 5038.470960549144, 5064.898702025976, 5104.923426148611, 5109.565686916617, 4969.0, 5071.543561079502, 5123.385193776752, 5134.306868572732, 5138.306328645641, 4894.5594896459315, 4934.654574179809, 4946.530079642446, 4957.950420495803, 5051.494850514938, 5075.822346217883, 5088.109580823341, 5100.132977393852, 5192.8961420771375, 5195.671435255675, 5015.974920125376, 5104.923426148611, 5152.793888244466, 5168.664036837594, 5195.350581177353, 5338.0925242708445, 5379.246905433203, 5432.837014889559, 5445.809396671137, 5468.234447177399, 5860.296764388258, 5875.764969401219, 5876.823695289148, 5971.343152253248, 5979.910301345483, 5956.52347812174, 5992.310884248323, 5997.760089596411, 6009.248843894513, 6017.097435384683, 5362.249285100089, 5406.378266499363, 5482.17767334899, 5513.807016754475, 5516.393196748354, 6044.455998960027, 6080.0575910733905, 6085.513158947362, 6086.482648974887, 6092.329843717188, 5813.7383817728305, 5822.737976791054, 5831.475167234969, 5834.3290521589715, 5845.561582881301, 5629.662220266797, 5641.971790141023, 5746.9425305747245, 5785.218995435563, 5793.739281732248, 5829.125631155276, 5831.533477321804, 5840.678762668094, 5861.41385861419, 5876.588638795329, 5812.215350927655, 5858.091995740667, 5868.207791948118, 5872.412758724179, 5877.5591830612875, 4462.553744625511, 4513.119941611354, 4538.568835960645, 4585.6102231310715, 4601.7699115044115, 4116.938245926313, 4139.068709540329, 4157.937630935538, 4170.895727606834, 4191.161767646483, 5696.3449203341315, 5702.030654788696, 5704.144378343199, 5705.400932902068, 5731.226284451629, 5703.657780533182, 5736.799212027559, 5910.911336329958, 5914.408559144051, 5919.348871624118, 5572.192032155314, 5580.414056524088, 5587.357453892773, 5682.460166284196, 5710.114932185518, 5102.285680004802, 5104.132297509433, 5112.156494178419, 5112.182050871843, 5119.10415677255, 5992.850178745566, 6052.092186172109, 6170.228721409824, 6224.626522408579, 6232.501399887998, 5881.3236477803885, 5885.73514191871, 5902.586818922806, 5970.611910225822, 5997.940020599738, 6234.251889773256, 6265.4361107500545, 6267.185265915402, 6270.184875966278, 6271.0, 5631.070873305859, 5816.738246778989, 5828.300603927556, 5832.9708351457975, 5860.882782344414, 5769.192313076257, 5990.221271234712, 6015.218021657157, 6045.0, 6053.878922421615, 5848.064309710426, 5862.325832529314, 5870.9412905872105, 5872.119182122716, 5875.089361149029, 5705.172749951317, 5838.2702162229725, 5843.620164689281, 5844.12338149264, 5845.532357411312, 5575.637583557056, 5634.774609015593, 5718.370979192202, 5746.971265143815, 5751.654900705971, 5894.0, 5897.970510147422, 5900.881982360414, 5901.704914754331, 5915.112733090071, 5496.1755736639825, 5745.569082318926, 5747.109198074305, 5754.482096611325, 5755.913661295168], "value": 5472.667564843391, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.8461415417837, 589.69041253342, 621.5431657731566, 647.6017249391625, 664.1830548425434, 34710.0, 46017.0, 46616.0, 46751.53248467515, 46847.06305873881, 46541.0, 46733.7663311683, 46946.53053469464, 47039.29441058387, 47112.76443617777, 8373.706920257791, 8914.509701966406, 9070.138336857988, 9071.773205669879, 9077.63689452421, 8672.783180420476, 10545.103666188383, 10868.836967445495, 10872.891271087306, 11157.330560166376, 10973.725656858562, 11018.50416731249, 11031.503582338773, 11042.227044106916, 11047.447627618627, 10812.405317707522, 10864.185186110994, 10868.07621352186, 10872.130229581615, 10945.343279403261, 10729.570817167303, 10774.515146818412, 10806.837897431546, 10820.0, 10824.945875270652, 45160.0, 45302.32046519305, 45528.08943821105, 45528.77235613834, 45583.31625025594, 3586.4261718124976, 3669.3945498992634, 3906.1915380816076, 4066.207089617526, 4353.107612939371, 33374.833125834455, 33941.490877636854, 34097.82951085229, 34423.48364774505, 35108.824455877555, 4380.693351465398, 4394.934075988863, 4494.415725955638, 4507.594316511497, 4569.492067617678, 247274.0, 247416.0, 248168.0, 361610.0, 362928.0, 66473.33526664769, 66927.33072669308, 66987.0, 67098.3290167092, 67121.32878671249, 40940.79529602393, 42466.0, 42552.57447425548, 44390.33414498785, 44480.3327950081, 19163.32928347501, 19279.80720192808, 19349.12928918174, 19349.12928918202, 19353.225870965285, 12545.874541254652, 12788.0, 14554.345054472575, 14670.63323416923, 14755.77866332006, 20446.284380046625, 21341.679874801892, 21371.35885923425, 21428.78571214299, 21481.46296342604, 7316.487845850739, 7425.480216384909, 7444.8883266751045, 7467.327940485382, 7510.4742668013805, 1001.5192707500295, 1040.8282633365409, 1059.210887888528, 1159.3623507071077, 1212.1999480342931, 34727.305453891284, 34966.426510807076, 35538.0, 35568.466473002925, 35621.64378356235, 1145.2098052344022, 1201.4473342262656, 1214.860291066521, 1249.1318533619228, 1259.817326487654, 18500.259989600265, 18713.81286187148, 18805.0, 18908.43274701761, 19008.334708285143, 421014.0, 542014.0, 543405.0, 543574.0, 543897.0, 65900.34099658942, 66421.33578664248, 66767.0, 66829.33170668328, 66860.66569667218, 1220.87791220879, 1362.3869258833367, 1364.195124876308, 1419.8083258760141, 1453.0772959171002, 27902.0, 36799.60802547826, 36878.44682329821, 38786.2242755149, 39515.2096958065, 62332.0, 63187.0, 63229.0, 63304.0, 63454.0, 382329.0, 383573.0, 383791.0, 384083.0, 386180.0, 28753.281167970967, 30018.69981300159, 32260.0, 32327.676723232467, 32416.675833241366, 50347.0, 51326.74336628293, 51369.486305137965, 51667.0, 52433.47566524438, 43476.78261608672, 43486.782566086964, 43809.56190438055, 44420.11159776851, 45509.08981820411, 43690.135110308365, 45131.0, 45443.54556454393, 45534.54465455303, 46410.53589464062, 46166.0, 46454.76772616115, 46776.29835552401, 47406.28890566575, 47700.284495731896, 37527.43708844424, 40766.0, 40881.38677919893, 40901.1041670825, 41186.79406602948, 30529.847350763994, 30585.08244752661, 30608.693913061474, 30735.385292294475, 31153.221169470038], "value": 21545.9730740097, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [424.18556371766203, 427.5661108624646, 427.69633560172275, 432.2155288152004, 450.2413433364779, 18520.536986575342, 19036.524086897836, 20187.697184542245, 20380.38858834237, 20402.183912643493, 17332.046737429435, 19048.61902761944, 19669.114889829958, 19766.505837354074, 20111.49721256969, 5235.55497782689, 5478.424765399635, 5487.094629386146, 5488.067028605146, 5489.4236105208975, 5319.069162896478, 5397.595180361469, 5458.727063646822, 5475.890482190353, 5801.129830525434, 5821.825345239649, 5827.708614569276, 5828.795992140276, 5828.970855145718, 5834.941650583503, 5644.491995720385, 5831.912521312183, 5834.329052159013, 5842.24050873388, 5888.941110588882, 5355.169948657965, 5363.383210930754, 5364.088105022156, 5372.274742909696, 5374.328208973879, 15068.924655376763, 15151.090934543963, 15172.24138793067, 15215.543533694006, 20762.48093797652, 2325.6278995360663, 2465.963010554843, 2525.229804909502, 2727.7408646178583, 2747.7527022568065, 10735.463226838627, 11023.559057637685, 11171.944140279247, 11181.44092795365, 11234.382108984002, 2019.3840878532042, 2201.4496375906024, 2317.165820304689, 2387.3288697911357, 2393.868337241451, 89227.0, 97658.0, 104734.0, 106138.46930765297, 109927.0, 17611.911940440215, 19008.809911900706, 19012.904935475235, 19060.809391905903, 19264.61470770577, 35838.64161358353, 35923.28153436917, 36070.0, 36327.4550881737, 36396.818015909754, 10640.84038739404, 10666.78666426667, 10779.568817247222, 10833.133349332034, 11198.38408887519, 8826.382153249338, 8844.204021638083, 9077.0, 9237.530169934647, 9455.810883782286, 9300.767480812898, 9348.532573371303, 9505.952470237604, 9626.229901607994, 9762.267829912644, 3383.052745231339, 3419.076849250688, 3465.480177973274, 3561.2521370511963, 3737.4020156774786, 949.924006079512, 999.7550600102876, 1033.5917312661607, 1073.7237057438124, 1118.6308518188978, 19626.411207663794, 21473.46316342104, 21525.677114842976, 21534.676979845313, 21582.35252942414, 1013.2299452416216, 1034.2656713733184, 1043.9269251152498, 1047.1151876664208, 1072.710368200597, 11421.0, 12003.039756819433, 12056.517739290506, 12142.75714485723, 12151.756964860653, 513155.0, 516356.0, 520536.0, 527453.0, 529500.0, 56849.715751420976, 80129.59935200404, 100702.4964875171, 101738.0, 105308.0, 997.4563862694848, 1000.2548101664306, 1020.5305559442592, 1021.3922715983978, 1040.6461802987171, 18404.987725675215, 18561.35035273759, 19169.80830191736, 19209.71185432192, 19399.90300048491, 43278.0, 43319.35020974751, 43358.56641433672, 43941.560584393745, 44412.0, 61566.0, 62028.0, 62854.68572657107, 63635.36364636479, 65137.34862651502, 8862.42394244372, 8885.777855553662, 8922.330825188006, 9164.633414663605, 11521.596744113916, 13495.797563036758, 13523.377194736695, 13717.931410342884, 14092.436302548193, 14299.499517516837, 12363.443645035815, 12382.380880956096, 12470.314132722424, 12577.622671319876, 12647.747045058863, 12540.749185016066, 12725.745485090061, 12959.546415875398, 12972.0, 13074.477020919438, 11714.765704685688, 12750.872491275339, 12859.614211573667, 12986.415611297703, 13142.540011099565, 12874.16317939331, 12938.417771200131, 13072.084954053125, 13091.803622945854, 13204.471821127046, 12579.433925473193, 12618.305993170097, 12741.044421668597, 12818.61544153677, 12838.55065072718], "value": 10521.840835417135, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1344.3950222399922, 1501.5270189890186, 1524.4054818620737, 1685.401682402747, 1835.85313174946, 7706.576138312391, 8213.0, 8432.156784321573, 8808.29533637309, 8824.470531768098, 8639.438436501623, 8714.651413943435, 8715.564221788902, 8717.389782715196, 8730.301575873931, 2502.737212592679, 2527.9620805687928, 2531.746825317472, 2537.124691981273, 2543.300592337104, 2460.360306320352, 2482.5283196192668, 2484.8881800319027, 2497.8126640501946, 2506.9972011195578, 2429.6355546667965, 2444.352246654629, 2447.6328550717444, 2451.399407145243, 2451.938701532467, 2419.41933935855, 2430.7083150021936, 2432.6351047342864, 2435.427674496492, 2451.84063035903, 2395.0539536883007, 2411.023535468138, 2436.2691192642314, 2464.051340234005, 2465.161844972718, 8526.914730852674, 8798.252148567379, 8867.955660221658, 8875.955620221923, 8876.201141897196, 5401.3248343957, 5477.096279113942, 5539.501444869981, 5620.297462817148, 5621.971890140564, 3508.28080243552, 3582.7850328980344, 3665.395209790408, 3669.889903302905, 3671.284099600579, 1162.953481860733, 1177.3995262416145, 1182.4560702077056, 1206.7465832175253, 2155.622766015941, 11917.702057448547, 12355.0, 12378.257304561756, 12380.319082450462, 12410.875891241063, 4598.2412901871485, 4620.699654522513, 4632.490426053131, 4658.161530924466, 4671.532846715301, 9474.95262523683, 9476.763080922894, 9482.099200575934, 9485.857712134324, 9486.146246837818, 5324.707141107277, 5325.920111198335, 5340.465953404629, 5342.385625653022, 5342.8931421372135, 4116.485439320085, 4335.82656693735, 4342.392065110887, 4994.026164897883, 5050.191969284971, 3845.115623406632, 3858.498395208605, 3955.2287303976022, 3959.584243654375, 3959.7228194026143, 1208.112037652325, 1230.0958795285458, 1237.059834525767, 1243.104964425612, 1247.9563215287421, 866.4281574161023, 905.6513242401722, 1011.1152741351318, 1023.7389465686202, 1032.3238278927315, 5912.379200183918, 5962.522998160223, 6074.817755467343, 6156.138140660311, 6292.968535157295, 484.9975750121227, 980.8234517786724, 1056.799208150449, 1077.4612693653173, 1091.7434402915308, 3911.2177564486647, 4064.7561146330722, 4108.322126849036, 4135.338345864648, 4138.52406973202, 10693.358398496115, 10826.0, 10942.562297508011, 10959.397233152253, 10966.177536684621, 10630.255882088335, 10636.202284828514, 10675.466226688635, 10853.728656783644, 10888.836667449994, 8253.215944485264, 8291.253787159185, 8311.293540049042, 8484.575771211415, 8512.829743405096, 5868.2077919480325, 5895.380984996514, 5917.230760001173, 5931.169636251015, 6001.939980600138, 9950.402975821475, 9973.60105595768, 10121.797564048531, 10244.282900196915, 10265.076143147153, 9907.900920990698, 10214.744631384276, 10223.0, 10316.123129534073, 10321.174306055347, 7226.096737907762, 7361.705531778669, 7366.594837284001, 7366.77899663011, 7368.189499155196, 8413.747587572383, 8421.368397370345, 8472.618732156945, 8477.067522572635, 8483.533405662747, 7694.269044440769, 7714.652840622298, 7728.497647652885, 7799.103103143211, 7941.563214023284, 7602.885956710765, 7617.581033043236, 7677.654505547375, 7818.648160832662, 7914.722984695508, 6857.348551887562, 6858.828529286808, 6933.4106600939485, 6987.161540615159, 6992.615406152507, 5227.4249832517635, 5229.529342359054, 5333.813316533902, 5405.378381486022, 5524.1989911463415, 5375.354957405137, 5450.890982180414, 5512.779488820563, 5516.14499752539, 5557.888842223214], "value": 4706.367166169784, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.6429830826786, 347.52042181789136, 357.1107941226346, 360.36755494107837, 365.5138665574784, 5337.973310133449, 5422.457754224575, 5422.728863556821, 5444.1561557958485, 5444.183372494128, 5334.253204551366, 5348.91976620351, 5353.411124776271, 5356.54469370103, 5363.8122665706705, 3964.1477082427273, 4313.396124542566, 4319.827206911736, 4321.459817522802, 4355.950834415921, 3801.923961520768, 4102.589741025903, 4257.489101307848, 4267.359896015607, 4293.527711951683, 4205.621494065534, 4225.746455212697, 4227.492700875884, 4237.533871274158, 4250.128723611652, 4218.514870789868, 4236.216299984513, 4257.14857028594, 4260.444937597786, 4269.423627810237, 3532.982335088308, 3642.0530662028063, 3656.579493358271, 3793.0, 3822.445745366934, 5203.635745497817, 5203.661761985497, 5225.529702326809, 5233.528982391603, 5257.316548848664, 4821.264344835857, 4830.637702172316, 4831.130396528623, 4866.975665121687, 4897.142999975025, 5319.388270348921, 5476.58925580579, 5493.670379777186, 5538.0, 5555.388907220203, 4130.421740956269, 4133.503979522447, 4144.0, 4148.377743338493, 4162.105147393295, 5555.972220138873, 5613.691246981414, 5855.648661080306, 5862.384449632812, 5866.354700982888, 4155.709100362946, 4165.291900376943, 4189.874303770892, 4193.790310484464, 4206.20082184384, 4254.851300093433, 4257.552432173076, 4296.183725092223, 4299.527052024275, 4301.870943871689, 4530.97734511332, 4792.832250871203, 4836.177849765549, 4853.417589889236, 4873.439554451284, 5612.494875461228, 5651.265335506358, 5671.241915006279, 5693.3168019837885, 5707.800226992035, 1414.7524183267888, 1425.1947649577955, 1426.2013272567397, 1437.2669938331526, 1441.67562298482, 950.3632566180676, 991.7074463033423, 1000.8598796168542, 1002.283367392318, 1005.8491226315965, 5316.989771943318, 5325.281087053276, 5337.706426146521, 5365.222042803772, 5365.275687782178, 5515.034868898007, 5560.332760068818, 5564.638298510584, 5588.720563971785, 5616.326040875121, 5117.488251174853, 5317.494837990384, 5363.919541206885, 5373.274607927958, 5410.296661434067, 2955.9113226603235, 2978.434097521464, 2982.925426864346, 2990.5065664165168, 2992.1921081307923, 5853.239078919798, 5865.20819689345, 5874.089516125007, 5893.852653683693, 5897.882042359214, 5577.2191893135, 5867.471927526458, 5879.706014699248, 5883.323417807007, 5904.3172695781495, 6110.4195101466175, 6112.908306375408, 6121.296050954197, 6133.9079913802225, 6162.691865406801, 5603.327600687943, 5784.363719990882, 5795.246617939641, 5811.418858114154, 5835.649861008353, 5712.485876271156, 5722.914156287576, 5727.198192253171, 5738.97407721882, 5740.339860915881, 5825.0, 5919.467247947706, 5920.230370051866, 5954.910676339771, 6028.779854102234, 4043.1913617276073, 4154.27894728953, 4162.791860407028, 4181.916361672688, 4191.512013235258, 5582.692951887685, 5781.525710943851, 5781.5663825214115, 5782.942170578241, 5788.189653448437, 5603.159526071122, 5624.493795558419, 5630.915536266877, 5634.2393776841245, 5646.604737668324, 5612.579056570692, 5624.550035997192, 5629.0, 5630.690312032878, 5646.85882852932, 5343.893122137458, 5535.750891209825, 5578.525825304894, 5593.881223755184, 5603.327600687943, 5607.607467477237, 5639.8590035249445, 5641.435856414326, 5642.294713160855, 5642.887142257214, 5505.256790333254, 5508.0, 5508.383517828999, 5518.779248830002, 5533.474319939599], "value": 4308.585690230997, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [774.372758065967, 784.9293563579276, 804.6861723927666, 826.1696994520507, 837.6272558711372, 13147.145435546694, 13554.322283885804, 13780.793288100662, 13904.582862514128, 13988.440462381517, 12986.41561129749, 13073.73852522949, 13149.0, 13230.867691323085, 13231.735365292689, 738.265425901229, 753.0210726056132, 872.2585802068223, 877.7542288159294, 879.2350654930219, 875.2341701011615, 879.4503435352905, 879.4811061473729, 880.2122100719852, 880.6873559886244, 902.7382059202823, 906.134641417448, 906.188960880012, 906.6282824042144, 908.0601577367426, 901.7565257380536, 902.0753727429371, 902.4810733828075, 902.5622573052098, 903.2277402820625, 659.9835004124888, 661.5170925224613, 661.6790856434625, 661.867626474707, 662.1855118204587, 12295.815562766566, 12767.106302558825, 12811.167274127152, 12850.0, 13775.586732398044, 12610.369481525888, 12868.549600764021, 12894.032947528973, 13084.280364579945, 13095.869041309561, 11459.197856150073, 11470.254433461798, 11591.76816463666, 11639.243449175861, 11821.290722556674, 3793.7534060285993, 3794.7343685941996, 3809.276237514863, 3877.8836634901, 3931.8623848165175, 57676.42323576753, 58205.99999999958, 62948.37051629471, 63754.0, 64481.355186448, 11377.658670239905, 11407.144464165222, 11470.369129697947, 11579.942100289445, 11666.241694289844, 19063.904680476786, 19120.426387208405, 19189.0, 19450.610987780165, 19701.734300555334, 8409.453385529921, 8420.915790842135, 8424.831503369898, 8465.915340846635, 8660.332920841412, 4500.437445319335, 4572.6799124061, 4620.722756634613, 4681.180793361148, 4761.119192949246, 3475.721942244665, 3557.6975957043423, 3595.658412450813, 3596.2447885944243, 3600.1719604491113, 615.7198474694003, 625.9061140828821, 631.9494440444753, 640.2732898160622, 640.3628389752133, 686.6909890549273, 736.9447291453055, 745.1542499263267, 796.3469954637142, 812.8740045292989, 9219.262459003263, 9512.714618561455, 9591.856122158173, 10286.588536458457, 10289.897101028893, 622.6170904893548, 739.9788292156896, 765.5215490318551, 793.131520984521, 800.543690096651, 4708.646851486153, 4752.477227504972, 4859.927101093486, 4860.416749990024, 4912.263160525949, 55629.44370556324, 55661.165082523796, 55685.721571391885, 62464.68767656224, 80038.59980700059, 46083.0, 60137.39862601405, 81259.0, 83709.16290837135, 85016.57491712502, 66818.33181668218, 67552.66223668949, 67728.3227167722, 67873.66063169751, 68700.0, 10054.69835904924, 10312.742181445525, 10349.0, 10484.108850747773, 10502.422366769595, 45624.77187614041, 45754.31368529541, 46090.308645369674, 46763.766181168874, 47449.28826067681, 56401.307960761245, 65080.34919650743, 66248.0, 67492.0, 68532.0, 12659.0, 12786.104972652198, 12892.677683057624, 13217.669558261121, 13417.66455838612, 12329.938350308192, 12475.563355282522, 14548.345324460637, 14862.702745945237, 15082.17048062367, 12784.488620455078, 13344.199348039148, 13700.65748356299, 14688.0, 14784.33470493852, 13161.670958226121, 13207.009474289274, 13335.933320333335, 13833.792493112813, 14015.656683341558, 13935.233562154179, 14361.712765744836, 14501.20243386624, 14520.564383068524, 14695.853041469449, 10416.32293900894, 10852.511636976196, 11037.558497660324, 11263.493142808757, 11346.319220846775, 11828.526858925547, 12124.939375303067, 12334.444949977093, 12363.443645036175, 12574.748505029665], "value": 7222.7289318055, "unit": "score"}], "name": "dromaeo_css", "value": 7526.119088960941, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 112.0, 113.0, 113.0, 113.0, 112.0, 112.0, 112.0, 111.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 121.0, 123.0, 158.0, 119.0, 119.0, 123.0, 118.0, 156.0, 119.0], "value": 130.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 163.0, 162.0, 161.0, 161.0, 162.0, 162.0, 161.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 78.0, 107.0, 75.0, 76.0, 76.0, 75.0, 113.0, 75.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 112.0, 81.0, 82.0, 82.0, 103.0, 81.0, 81.0, 112.0], "value": 89.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 145.0, 146.0, 146.0, 147.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 84.0, 84.0, 85.0, 85.0, 85.0, 84.0, 84.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 51.0, 51.0, 51.0, 50.0, 51.0, 51.0, 54.0, 50.0], "value": 51.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 60.0, 60.0, 60.0, 59.0, 63.0, 59.0, 59.0, 62.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 80.0, 75.0, 75.0, 77.0, 74.0, 83.0, 74.0, 74.0], "value": 76.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 131.0, 118.0, 129.0, 119.0, 118.0, 118.0, 127.0, 162.0, 126.0], "value": 127.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 153.0, 153.0, 159.0, 156.0, 155.0, 154.0, 155.0, 154.0, 153.0], "value": 154.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 62.0, 62.0, 62.0, 62.0, 65.0, 61.0, 60.0, 61.0], "value": 62.2, "unit": "score"}], "name": "kraken", "value": 1455.0, "alertThreshold": 2.0}]} 15:52:50 INFO - Return code: 0 15:52:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:52:50 INFO - # TBPL SUCCESS # 15:52:50 INFO - Running post-action listener: _resource_record_post_action 15:52:50 INFO - [mozharness: 2017-01-11 23:52:50.962095Z] Finished run-tests step (success) 15:52:50 INFO - Running post-run listener: _resource_record_post_run 15:52:51 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 266240; Write bytes: 346853376; Read time: 24; Write time: 214652 15:52:51 INFO - TinderboxPrint: CPU usage
13.0% 15:52:51 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 24 15:52:51 INFO - TinderboxPrint: I/O write bytes / time
346,853,376 / 214,652 15:52:51 INFO - TinderboxPrint: CPU idle
8,260.0 (87.0%) 15:52:51 INFO - TinderboxPrint: CPU user
1,189.2 (12.5%) 15:52:51 INFO - TinderboxPrint: Swap in / out
0 / 0 15:52:51 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108175360; Read time: 0; Write time: 77716 15:52:51 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 262144; Write bytes: 238678016; Read time: 12; Write time: 136936 15:52:51 INFO - Running post-run listener: _upload_blobber_files 15:52:51 INFO - Blob upload gear active. 15:52:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:52:51 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 15:52:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:52:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:52:52 INFO - (blobuploader) - INFO - Open directory for files ... 15:52:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:52:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:52:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:52:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:52:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:52:52 INFO - (blobuploader) - INFO - Done attempting. 15:52:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:52:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:52:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:52:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:52:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:52:56 INFO - (blobuploader) - INFO - Done attempting. 15:52:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:52:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:52:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:52:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:52:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:52:57 INFO - (blobuploader) - INFO - Done attempting. 15:52:57 INFO - (blobuploader) - INFO - Iteration through files over. 15:52:57 INFO - Return code: 0 15:52:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:52:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:52:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e47c47014b93faa915427f5bc0842db22462088807cfb6eb4092f6912e330c470ab0653bbb02f593ed536b7c850f71b65b718fdf387e4501b039577305b94f85", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/13cfc4b71dc2ed91c22f022a33f93d0a44e3ebd3aa3721184b0850365daab7dac8d45dbaaa8e5c86779db802f5665592b43ed92e416b5f176452c602d786b93c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6311132db6410920a5b7cc42ecac75566c5ac8684f0d57a5c4623522cd9a81d011baf7655c552ad7577848a97e66121749bba33d22a9ca1fa233055babaac9de"} 15:52:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:52:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:52:57 INFO - Contents: 15:52:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e47c47014b93faa915427f5bc0842db22462088807cfb6eb4092f6912e330c470ab0653bbb02f593ed536b7c850f71b65b718fdf387e4501b039577305b94f85", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/13cfc4b71dc2ed91c22f022a33f93d0a44e3ebd3aa3721184b0850365daab7dac8d45dbaaa8e5c86779db802f5665592b43ed92e416b5f176452c602d786b93c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6311132db6410920a5b7cc42ecac75566c5ac8684f0d57a5c4623522cd9a81d011baf7655c552ad7577848a97e66121749bba33d22a9ca1fa233055babaac9de"} 15:52:57 INFO - Running post-run listener: copy_logs_to_upload_dir 15:52:57 INFO - Copying logs to upload dir... 15:52:57 INFO - mkdir: /builds/slave/test/build/upload/logs 15:52:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.434609 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-01-11 15:52:56.845784) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-11 15:52:56.849453) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1484177542.807542-714196871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e47c47014b93faa915427f5bc0842db22462088807cfb6eb4092f6912e330c470ab0653bbb02f593ed536b7c850f71b65b718fdf387e4501b039577305b94f85", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/13cfc4b71dc2ed91c22f022a33f93d0a44e3ebd3aa3721184b0850365daab7dac8d45dbaaa8e5c86779db802f5665592b43ed92e416b5f176452c602d786b93c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6311132db6410920a5b7cc42ecac75566c5ac8684f0d57a5c4623522cd9a81d011baf7655c552ad7577848a97e66121749bba33d22a9ca1fa233055babaac9de"} build_url:https://queue.taskcluster.net/v1/task/NDRFhHCOROiOUFlkRacjyg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011343 build_url: 'https://queue.taskcluster.net/v1/task/NDRFhHCOROiOUFlkRacjyg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e47c47014b93faa915427f5bc0842db22462088807cfb6eb4092f6912e330c470ab0653bbb02f593ed536b7c850f71b65b718fdf387e4501b039577305b94f85", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/13cfc4b71dc2ed91c22f022a33f93d0a44e3ebd3aa3721184b0850365daab7dac8d45dbaaa8e5c86779db802f5665592b43ed92e416b5f176452c602d786b93c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6311132db6410920a5b7cc42ecac75566c5ac8684f0d57a5c4623522cd9a81d011baf7655c552ad7577848a97e66121749bba33d22a9ca1fa233055babaac9de"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-11 15:52:56.874814) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 15:52:56.875168) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1484177542.807542-714196871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004447 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 15:52:56.959176) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-11 15:52:56.959498) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-11 15:52:56.959926) ========= ========= Total master_lag: 0.16 =========