builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-045 starttime: 1475553759.68 results: success (0) buildid: 20161003200701 builduid: 678ab9f971ef4f8e800ca592e1f0ddaf revision: adb484f84dec4b9d6a216ef3f4e1887fc3ae8084 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 21:02:39.675807) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 21:02:39.676242) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 21:02:39.676555) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 21:02:39.716951) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 21:02:39.717275) ========= 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=4300f881736b422476174874000001bc-1475553034.378506-972252565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-03 21:02:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 22.4M=0.001s 2016-10-03 21:02:40 (22.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.077506 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 21:02:39.811459) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 21:02:39.812231) ========= 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=4300f881736b422476174874000001bc-1475553034.378506-972252565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014591 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 21:02:39.866041) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 21:02:39.866429) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev adb484f84dec4b9d6a216ef3f4e1887fc3ae8084 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev adb484f84dec4b9d6a216ef3f4e1887fc3ae8084 --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=4300f881736b422476174874000001bc-1475553034.378506-972252565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-03 21:02:40,344 truncating revision to first 12 chars 2016-10-03 21:02:40,344 Setting DEBUG logging. 2016-10-03 21:02:40,344 attempt 1/10 2016-10-03 21:02:40,344 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/adb484f84dec?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-03 21:02:40,657 unpacking tar archive at: mozilla-central-adb484f84dec/testing/mozharness/ program finished with exit code 0 elapsedTime=0.632650 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 21:02:40.513981) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 21:02:40.514303) ========= script_repo_revision: adb484f84dec4b9d6a216ef3f4e1887fc3ae8084 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 21:02:40.514729) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 21:02:40.515089) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 21:02:40.525677) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-10-03 21:02:40.525974) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4300f881736b422476174874000001bc-1475553034.378506-972252565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:02:41 INFO - MultiFileLogger online at 20161003 21:02:41 in /builds/slave/test 21:02:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 21:02:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:02:41 INFO - {'append_to_log': False, 21:02:41 INFO - 'base_work_dir': '/builds/slave/test', 21:02:41 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 21:02:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:02:41 INFO - 'branch': 'Firefox-Non-PGO', 21:02:41 INFO - 'buildbot_json_path': 'buildprops.json', 21:02:41 INFO - 'config_files': ('talos/linux_config.py',), 21:02:41 INFO - 'default_actions': ('clobber', 21:02:41 INFO - 'read-buildbot-config', 21:02:41 INFO - 'download-and-extract', 21:02:41 INFO - 'populate-webroot', 21:02:41 INFO - 'create-virtualenv', 21:02:41 INFO - 'install', 21:02:41 INFO - 'run-tests'), 21:02:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:02:41 INFO - 'download_minidump_stackwalk': True, 21:02:41 INFO - 'download_symbols': 'ondemand', 21:02:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:02:41 INFO - 'tooltool.py': '/tools/tooltool.py', 21:02:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:02:41 INFO - '/tools/misc-python/virtualenv.py')}, 21:02:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:02:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:02:41 INFO - 'installer_path': 'installer.exe', 21:02:41 INFO - 'log_level': 'info', 21:02:41 INFO - 'log_name': 'talos', 21:02:41 INFO - 'log_to_console': True, 21:02:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:02:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:02:41 INFO - 'opt_config_files': (), 21:02:41 INFO - 'pip_index': False, 21:02:41 INFO - 'sps_profile': False, 21:02:41 INFO - 'sps_profile_interval': 0, 21:02:41 INFO - 'suite': 'dromaeojs', 21:02:41 INFO - 'system_bits': '32', 21:02:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:02:41 INFO - 'title': 'talos-linux64-ix-045', 21:02:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:02:41 INFO - 'use_talos_json': True, 21:02:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:02:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:02:41 INFO - 'work_dir': 'build'} 21:02:41 INFO - [mozharness: 2016-10-04 04:02:41.104955Z] Running clobber step. 21:02:41 INFO - Running pre-action listener: _resource_record_pre_action 21:02:41 INFO - Running main action method: clobber 21:02:41 INFO - rmtree: /builds/slave/test/build 21:02:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:02:42 INFO - Running post-action listener: _resource_record_post_action 21:02:42 INFO - [mozharness: 2016-10-04 04:02:42.085876Z] Finished clobber step (success) 21:02:42 INFO - [mozharness: 2016-10-04 04:02:42.085980Z] Running read-buildbot-config step. 21:02:42 INFO - Running pre-action listener: _resource_record_pre_action 21:02:42 INFO - Running main action method: read_buildbot_config 21:02:42 INFO - Using buildbot properties: 21:02:42 INFO - { 21:02:42 INFO - "project": "", 21:02:42 INFO - "product": "firefox", 21:02:42 INFO - "script_repo_revision": "production", 21:02:42 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 21:02:42 INFO - "repository": "", 21:02:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 21:02:42 INFO - "buildid": "20161003200701", 21:02:42 INFO - "pgo_build": "False", 21:02:42 INFO - "basedir": "/builds/slave/test", 21:02:42 INFO - "buildnumber": 230, 21:02:42 INFO - "slavename": "talos-linux64-ix-045", 21:02:42 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:02:42 INFO - "platform": "ubuntu64_hw", 21:02:42 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 21:02:42 INFO - "branch": "mozilla-central", 21:02:42 INFO - "repo_path": "mozilla-central", 21:02:42 INFO - "revision": "adb484f84dec4b9d6a216ef3f4e1887fc3ae8084", 21:02:42 INFO - "stage_platform": "linux64", 21:02:42 INFO - "builduid": "678ab9f971ef4f8e800ca592e1f0ddaf", 21:02:42 INFO - "slavebuilddir": "test" 21:02:42 INFO - } 21:02:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/Rm8dUGc_TgijMxFkv85BwA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 21:02:42 INFO - Running post-action listener: _resource_record_post_action 21:02:42 INFO - [mozharness: 2016-10-04 04:02:42.088393Z] Finished read-buildbot-config step (success) 21:02:42 INFO - [mozharness: 2016-10-04 04:02:42.088481Z] Running download-and-extract step. 21:02:42 INFO - Running pre-action listener: _resource_record_pre_action 21:02:42 INFO - Running main action method: download_and_extract 21:02:42 INFO - mkdir: /builds/slave/test/build/tests 21:02:42 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')]} 21:02:42 INFO - trying https://queue.taskcluster.net/v1/task/Rm8dUGc_TgijMxFkv85BwA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:02:42 INFO - Downloading https://queue.taskcluster.net/v1/task/Rm8dUGc_TgijMxFkv85BwA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:02:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rm8dUGc_TgijMxFkv85BwA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:02:42 INFO - Downloaded 1361 bytes. 21:02:42 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:02:42 INFO - Using the following test package requirements: 21:02:42 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:02:42 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:02:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:02:42 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:02:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:02:42 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:02:42 INFO - u'jsshell-linux-x86_64.zip'], 21:02:42 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:02:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:02:42 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:02:42 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:02:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:02:42 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:02:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:02:42 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:02:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:02:42 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:02:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:02:42 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:02:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Rm8dUGc_TgijMxFkv85BwA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:02:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rm8dUGc_TgijMxFkv85BwA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:02:42 INFO - Fetch https://queue.taskcluster.net/v1/task/Rm8dUGc_TgijMxFkv85BwA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:02:43 INFO - Http code: 200 21:02:43 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 21:02:43 INFO - x-amz-cf-id: T234qUAEhoRwA0NzdaI6aMN2ovqIdZgSlBl7qomq934Sv8ZTjnPCow== 21:02:43 INFO - x-amz-version-id: TRl8GwRYl0_of6nP9pw2fJ.HhmtFTuVM 21:02:44 INFO - Expected file size: 20420415 21:02:44 INFO - Obtained file size: 20420415 21:02:48 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:02:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Rm8dUGc_TgijMxFkv85BwA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:02:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rm8dUGc_TgijMxFkv85BwA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:02:48 INFO - Fetch https://queue.taskcluster.net/v1/task/Rm8dUGc_TgijMxFkv85BwA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:02:48 INFO - Http code: 200 21:02:48 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 21:02:48 INFO - x-amz-cf-id: nwqP4jrmBro7nwHEOH6Pwo-Ddrv6yQXtw4XKxjsbp_96hN8Wmnmgkg== 21:02:48 INFO - x-amz-version-id: TRl8GwRYl0_of6nP9pw2fJ.HhmtFTuVM 21:02:49 INFO - Expected file size: 20420415 21:02:49 INFO - Obtained file size: 20420415 21:02:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Rm8dUGc_TgijMxFkv85BwA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 21:02:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rm8dUGc_TgijMxFkv85BwA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:02:53 INFO - Fetch https://queue.taskcluster.net/v1/task/Rm8dUGc_TgijMxFkv85BwA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 21:02:54 INFO - Http code: 200 21:02:54 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 21:02:54 INFO - x-amz-cf-id: VpZCm0VuyyDuRImq5MTJa9e-1mrq36PNb0Vv7gbJERzvAeh3btTvyA== 21:02:54 INFO - x-amz-version-id: JadYiw7De3pXNV.8tXIqPhwnrV8XAcY3 21:02:55 INFO - Expected file size: 14408522 21:02:55 INFO - Obtained file size: 14408522 21:02:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:55 INFO - trying https://queue.taskcluster.net/v1/task/Rm8dUGc_TgijMxFkv85BwA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:02:55 INFO - Downloading https://queue.taskcluster.net/v1/task/Rm8dUGc_TgijMxFkv85BwA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:02:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rm8dUGc_TgijMxFkv85BwA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:02:57 INFO - Downloaded 55830781 bytes. 21:02:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Rm8dUGc_TgijMxFkv85BwA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:02:57 INFO - mkdir: /builds/slave/test/properties 21:02:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:02:57 INFO - Writing to file /builds/slave/test/properties/build_url 21:02:57 INFO - Contents: 21:02:57 INFO - build_url:https://queue.taskcluster.net/v1/task/Rm8dUGc_TgijMxFkv85BwA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:02:58 INFO - Running post-action listener: _resource_record_post_action 21:02:58 INFO - Running post-action listener: set_extra_try_arguments 21:02:58 INFO - [mozharness: 2016-10-04 04:02:58.163151Z] Finished download-and-extract step (success) 21:02:58 INFO - [mozharness: 2016-10-04 04:02:58.163377Z] Running populate-webroot step. 21:02:58 INFO - Running pre-action listener: _resource_record_pre_action 21:02:58 INFO - Running main action method: populate_webroot 21:02:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:02:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:02:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:02:58 INFO - '--tppagecycles', 21:02:58 INFO - '7'], 21:02:58 INFO - 'tests': ['tsvgm']}}, 21:02:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:02:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:02:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:02:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:02:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:02:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:02:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:02:58 INFO - 'talos_options': ['--disable-e10s'], 21:02:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:02:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:02:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:02:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:02:58 INFO - 'talos_options': ['--disable-e10s'], 21:02:58 INFO - 'tests': ['damp', 'tps']}, 21:02:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:02:58 INFO - 'tests': ['damp', 'tps']}, 21:02:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:02:58 INFO - 'tests': ['dromaeo_dom']}, 21:02:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:02:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:02:58 INFO - 'tests': ['basic_compositor_video']}, 21:02:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:02:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:02:58 INFO - 'tests': ['a11yr', 21:02:58 INFO - 'ts_paint', 21:02:58 INFO - 'tpaint', 21:02:58 INFO - 'sessionrestore', 21:02:58 INFO - 'sessionrestore_no_auto_restore', 21:02:58 INFO - 'tabpaint']}, 21:02:58 INFO - 'other-e10s': {'tests': ['a11yr', 21:02:58 INFO - 'ts_paint', 21:02:58 INFO - 'tpaint', 21:02:58 INFO - 'sessionrestore', 21:02:58 INFO - 'sessionrestore_no_auto_restore', 21:02:58 INFO - 'tabpaint']}, 21:02:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:02:58 INFO - 'ts_paint', 21:02:58 INFO - 'tpaint', 21:02:58 INFO - 'sessionrestore', 21:02:58 INFO - 'sessionrestore_no_auto_restore', 21:02:58 INFO - 'tabpaint']}, 21:02:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:02:58 INFO - 'ts_paint', 21:02:58 INFO - 'tpaint', 21:02:58 INFO - 'sessionrestore', 21:02:58 INFO - 'sessionrestore_no_auto_restore', 21:02:58 INFO - 'tabpaint']}, 21:02:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:02:58 INFO - 'tests': ['a11yr', 21:02:58 INFO - 'ts_paint', 21:02:58 INFO - 'tpaint', 21:02:58 INFO - 'sessionrestore', 21:02:58 INFO - 'sessionrestore_no_auto_restore', 21:02:58 INFO - 'tabpaint']}, 21:02:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:02:58 INFO - 'tests': ['a11yr', 21:02:58 INFO - 'ts_paint', 21:02:58 INFO - 'tpaint', 21:02:58 INFO - 'sessionrestore', 21:02:58 INFO - 'sessionrestore_no_auto_restore', 21:02:58 INFO - 'tabpaint']}, 21:02:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:02:58 INFO - 'tests': ['tsvgx', 21:02:58 INFO - 'tsvgr_opacity', 21:02:58 INFO - 'tart', 21:02:58 INFO - 'tscrollx', 21:02:58 INFO - 'cart']}, 21:02:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:02:58 INFO - 'tsvgr_opacity', 21:02:58 INFO - 'tart', 21:02:58 INFO - 'tscrollx', 21:02:58 INFO - 'cart']}, 21:02:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:02:58 INFO - 'talos_options': ['--disable-e10s'], 21:02:58 INFO - 'tests': ['tp5o']}, 21:02:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:02:58 INFO - 'tests': ['tp5o']}, 21:02:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:02:58 INFO - 'talos_options': ['--disable-e10s', 21:02:58 INFO - '--xperf_path', 21:02:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:02:58 INFO - 'tests': ['tp5n']}, 21:02:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:02:58 INFO - 'talos_options': ['--xperf_path', 21:02:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:02:58 INFO - 'tests': ['tp5n']}}, 21:02:58 INFO - 'talos.zip': {'path': '', 21:02:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:02:58 INFO - Running post-action listener: _resource_record_post_action 21:02:58 INFO - [mozharness: 2016-10-04 04:02:58.185767Z] Finished populate-webroot step (success) 21:02:58 INFO - [mozharness: 2016-10-04 04:02:58.185865Z] Running create-virtualenv step. 21:02:58 INFO - Running pre-action listener: _resource_record_pre_action 21:02:58 INFO - Running main action method: create_virtualenv 21:02:58 INFO - Creating virtualenv /builds/slave/test/build/venv 21:02:58 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 21:02:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:02:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:02:58 INFO - Using real prefix '/usr' 21:02:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:02:58 INFO - Installing distribute.............................................................................................................................................................................................done. 21:03:00 INFO - Installing pip.................done. 21:03:00 INFO - Return code: 0 21:03:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:03:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:03:00 INFO - Reading from file tmpfile_stdout 21:03:00 INFO - Output received: 21:03:00 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) 21:03:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:03: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')]} 21:03:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:03:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:03: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')]} 21:03:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:03:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:03:00 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 0x7f5f00d86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1060ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105df60>, '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 0x105ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f1d0>, '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': '4300f881736b422476174874000001bc-1475553034.378506-972252565', '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 21:03:00 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 21:03:00 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 21:03:01 INFO - Using env: {'DISPLAY': ':0', 21:03:01 INFO - 'HOME': '/home/cltbld', 21:03:01 INFO - 'LANG': 'en_US.UTF-8', 21:03:01 INFO - 'LANGUAGE': 'en_US:en', 21:03:01 INFO - 'LOGNAME': 'cltbld', 21:03:01 INFO - 'MAIL': '/var/mail/cltbld', 21:03:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:03:01 INFO - 'MOZ_NO_REMOTE': '1', 21:03:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:03:01 INFO - 'NO_EM_RESTART': '1', 21:03:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:03:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:03:01 INFO - 'PWD': '/builds/slave/test', 21:03:01 INFO - 'SHELL': '/bin/bash', 21:03:01 INFO - 'SHLVL': '1', 21:03:01 INFO - 'TERM': 'linux', 21:03:01 INFO - 'TMOUT': '86400', 21:03:01 INFO - 'USER': 'cltbld', 21:03:01 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1475553034.378506-972252565', 21:03:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:03:01 INFO - '_': '/tools/buildbot/bin/python'} 21:03:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:03:01 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 21:03:01 INFO - Cleaning up... 21:03:01 INFO - Return code: 0 21:03:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:03: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')]} 21:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:03:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:03: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')]} 21:03:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:03:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:03: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', '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 0x7f5f00d86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1060ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105df60>, '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 0x105ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f1d0>, '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': '4300f881736b422476174874000001bc-1475553034.378506-972252565', '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 21:03: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', 'psutil>=3.1.1'] in /builds/slave/test/build 21:03: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 psutil>=3.1.1 21:03:01 INFO - Using env: {'DISPLAY': ':0', 21:03:01 INFO - 'HOME': '/home/cltbld', 21:03:01 INFO - 'LANG': 'en_US.UTF-8', 21:03:01 INFO - 'LANGUAGE': 'en_US:en', 21:03:01 INFO - 'LOGNAME': 'cltbld', 21:03:01 INFO - 'MAIL': '/var/mail/cltbld', 21:03:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:03:01 INFO - 'MOZ_NO_REMOTE': '1', 21:03:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:03:01 INFO - 'NO_EM_RESTART': '1', 21:03:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:03:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:03:01 INFO - 'PWD': '/builds/slave/test', 21:03:01 INFO - 'SHELL': '/bin/bash', 21:03:01 INFO - 'SHLVL': '1', 21:03:01 INFO - 'TERM': 'linux', 21:03:01 INFO - 'TMOUT': '86400', 21:03:01 INFO - 'USER': 'cltbld', 21:03:01 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1475553034.378506-972252565', 21:03:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:03:01 INFO - '_': '/tools/buildbot/bin/python'} 21:03:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:03:01 INFO - Downloading/unpacking psutil>=3.1.1 21:03:01 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 21:03:01 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 21:03:01 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 21:03:01 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 21:03:01 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 21:03:01 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 21:03:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:03:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:03:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:03:03 INFO - Installing collected packages: psutil 21:03:03 INFO - Running setup.py install for psutil 21:03:03 INFO - building 'psutil._psutil_linux' extension 21:03:03 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 21:03:03 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 21:03:03 INFO - building 'psutil._psutil_posix' extension 21:03:03 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 21:03:03 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 21:03:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:03:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:03:03 INFO - Successfully installed psutil 21:03:03 INFO - Cleaning up... 21:03:03 INFO - Return code: 0 21:03:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:03:03 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')]} 21:03:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:03:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:03:03 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')]} 21:03:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:03:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:03:03 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 0x7f5f00d86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1060ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105df60>, '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 0x105ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f1d0>, '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': '4300f881736b422476174874000001bc-1475553034.378506-972252565', '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 21:03:03 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 21:03:03 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 21:03:03 INFO - Using env: {'DISPLAY': ':0', 21:03:03 INFO - 'HOME': '/home/cltbld', 21:03:03 INFO - 'LANG': 'en_US.UTF-8', 21:03:03 INFO - 'LANGUAGE': 'en_US:en', 21:03:03 INFO - 'LOGNAME': 'cltbld', 21:03:03 INFO - 'MAIL': '/var/mail/cltbld', 21:03:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:03:03 INFO - 'MOZ_NO_REMOTE': '1', 21:03:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:03:03 INFO - 'NO_EM_RESTART': '1', 21:03:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:03:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:03:03 INFO - 'PWD': '/builds/slave/test', 21:03:03 INFO - 'SHELL': '/bin/bash', 21:03:03 INFO - 'SHLVL': '1', 21:03:03 INFO - 'TERM': 'linux', 21:03:03 INFO - 'TMOUT': '86400', 21:03:03 INFO - 'USER': 'cltbld', 21:03:03 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1475553034.378506-972252565', 21:03:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:03:03 INFO - '_': '/tools/buildbot/bin/python'} 21:03:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:03:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:03:04 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 21:03:04 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 21:03:04 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 21:03:04 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 21:03:04 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 21:03:04 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 21:03:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:03:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:03:06 INFO - Installing collected packages: mozsystemmonitor 21:03:06 INFO - Running setup.py install for mozsystemmonitor 21:03:06 INFO - Successfully installed mozsystemmonitor 21:03:06 INFO - Cleaning up... 21:03:06 INFO - Return code: 0 21:03:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:03:06 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')]} 21:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:03:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:03:06 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')]} 21:03:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:03:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:03:06 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 0x7f5f00d86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1060ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105df60>, '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 0x105ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f1d0>, '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': '4300f881736b422476174874000001bc-1475553034.378506-972252565', '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 21:03:06 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 21:03:06 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 21:03:06 INFO - Using env: {'DISPLAY': ':0', 21:03:06 INFO - 'HOME': '/home/cltbld', 21:03:06 INFO - 'LANG': 'en_US.UTF-8', 21:03:06 INFO - 'LANGUAGE': 'en_US:en', 21:03:06 INFO - 'LOGNAME': 'cltbld', 21:03:06 INFO - 'MAIL': '/var/mail/cltbld', 21:03:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:03:06 INFO - 'MOZ_NO_REMOTE': '1', 21:03:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:03:06 INFO - 'NO_EM_RESTART': '1', 21:03:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:03:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:03:06 INFO - 'PWD': '/builds/slave/test', 21:03:06 INFO - 'SHELL': '/bin/bash', 21:03:06 INFO - 'SHLVL': '1', 21:03:06 INFO - 'TERM': 'linux', 21:03:06 INFO - 'TMOUT': '86400', 21:03:06 INFO - 'USER': 'cltbld', 21:03:06 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1475553034.378506-972252565', 21:03:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:03:06 INFO - '_': '/tools/buildbot/bin/python'} 21:03:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:03:06 INFO - Downloading/unpacking jsonschema==2.5.1 21:03:06 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 21:03:06 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 21:03:06 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 21:03:06 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 21:03:06 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 21:03:06 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 21:03:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:03:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:03:08 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 21:03:08 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 21:03:08 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 21:03:08 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 21:03:08 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 21:03:08 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 21:03:08 INFO - Downloading functools32-3.2.3-2.tar.gz 21:03:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:03:08 INFO - warning: no files found matching '*.txt' 21:03:08 INFO - no previously-included directories found matching 'build' 21:03:08 INFO - no previously-included directories found matching 'dist' 21:03:08 INFO - no previously-included directories found matching '.git*' 21:03:08 INFO - Installing collected packages: jsonschema, functools32 21:03:08 INFO - Running setup.py install for functools32 21:03:08 INFO - warning: no files found matching '*.txt' 21:03:08 INFO - no previously-included directories found matching 'build' 21:03:08 INFO - no previously-included directories found matching 'dist' 21:03:08 INFO - no previously-included directories found matching '.git*' 21:03:08 INFO - Successfully installed jsonschema functools32 21:03:08 INFO - Cleaning up... 21:03:08 INFO - Return code: 0 21:03:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:03:08 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')]} 21:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:03:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:03:08 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')]} 21:03:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:03:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:03:08 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 0x7f5f00d86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1060ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105df60>, '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 0x105ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f1d0>, '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': '4300f881736b422476174874000001bc-1475553034.378506-972252565', '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 21:03:08 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 21:03:08 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 21:03:08 INFO - Using env: {'DISPLAY': ':0', 21:03:08 INFO - 'HOME': '/home/cltbld', 21:03:08 INFO - 'LANG': 'en_US.UTF-8', 21:03:08 INFO - 'LANGUAGE': 'en_US:en', 21:03:08 INFO - 'LOGNAME': 'cltbld', 21:03:08 INFO - 'MAIL': '/var/mail/cltbld', 21:03:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:03:08 INFO - 'MOZ_NO_REMOTE': '1', 21:03:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:03:08 INFO - 'NO_EM_RESTART': '1', 21:03:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:03:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:03:08 INFO - 'PWD': '/builds/slave/test', 21:03:08 INFO - 'SHELL': '/bin/bash', 21:03:08 INFO - 'SHLVL': '1', 21:03:08 INFO - 'TERM': 'linux', 21:03:08 INFO - 'TMOUT': '86400', 21:03:08 INFO - 'USER': 'cltbld', 21:03:08 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1475553034.378506-972252565', 21:03:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:03:08 INFO - '_': '/tools/buildbot/bin/python'} 21:03:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:03:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:03:09 INFO - Cleaning up... 21:03:09 INFO - Return code: 0 21:03:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:03:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:03:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:03:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:03:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:03:09 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 0x7f5f00d86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1060ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105df60>, '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 0x105ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f1d0>, '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': '4300f881736b422476174874000001bc-1475553034.378506-972252565', '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 21:03:09 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 21:03:09 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 21:03:09 INFO - Using env: {'DISPLAY': ':0', 21:03:09 INFO - 'HOME': '/home/cltbld', 21:03:09 INFO - 'LANG': 'en_US.UTF-8', 21:03:09 INFO - 'LANGUAGE': 'en_US:en', 21:03:09 INFO - 'LOGNAME': 'cltbld', 21:03:09 INFO - 'MAIL': '/var/mail/cltbld', 21:03:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:03:09 INFO - 'MOZ_NO_REMOTE': '1', 21:03:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:03:09 INFO - 'NO_EM_RESTART': '1', 21:03:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:03:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:03:09 INFO - 'PWD': '/builds/slave/test', 21:03:09 INFO - 'SHELL': '/bin/bash', 21:03:09 INFO - 'SHLVL': '1', 21:03:09 INFO - 'TERM': 'linux', 21:03:09 INFO - 'TMOUT': '86400', 21:03:09 INFO - 'USER': 'cltbld', 21:03:09 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1475553034.378506-972252565', 21:03:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:03:09 INFO - '_': '/tools/buildbot/bin/python'} 21:03:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:03:09 INFO - Downloading/unpacking blobuploader==1.2.4 21:03:09 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 21:03:09 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 21:03:09 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 21:03:09 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 21:03:09 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 21:03:09 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 21:03:11 INFO - Downloading blobuploader-1.2.4.tar.gz 21:03:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:03:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:03:11 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 21:03:11 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 21:03:11 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 21:03:11 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 21:03:11 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 21:03:11 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 21:03:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:03:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:03:11 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 21:03:11 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 21:03:11 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 21:03:11 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 21:03:11 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 21:03:11 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 21:03:11 INFO - Downloading docopt-0.6.1.tar.gz 21:03:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:03:11 INFO - Installing collected packages: blobuploader, requests, docopt 21:03:11 INFO - Running setup.py install for blobuploader 21:03:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:03:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:03:12 INFO - Running setup.py install for requests 21:03:12 INFO - Running setup.py install for docopt 21:03:12 INFO - Successfully installed blobuploader requests docopt 21:03:12 INFO - Cleaning up... 21:03:12 INFO - Return code: 0 21:03:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:03:12 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')]} 21:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:03:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:03:12 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')]} 21:03:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:03:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:03:12 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 0x7f5f00d86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1060ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105df60>, '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 0x105ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f1d0>, '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': '4300f881736b422476174874000001bc-1475553034.378506-972252565', '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 21:03:12 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 21:03:12 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 21:03:12 INFO - Using env: {'DISPLAY': ':0', 21:03:12 INFO - 'HOME': '/home/cltbld', 21:03:12 INFO - 'LANG': 'en_US.UTF-8', 21:03:12 INFO - 'LANGUAGE': 'en_US:en', 21:03:12 INFO - 'LOGNAME': 'cltbld', 21:03:12 INFO - 'MAIL': '/var/mail/cltbld', 21:03:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:03:12 INFO - 'MOZ_NO_REMOTE': '1', 21:03:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:03:12 INFO - 'NO_EM_RESTART': '1', 21:03:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:03:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:03:12 INFO - 'PWD': '/builds/slave/test', 21:03:12 INFO - 'SHELL': '/bin/bash', 21:03:12 INFO - 'SHLVL': '1', 21:03:12 INFO - 'TERM': 'linux', 21:03:12 INFO - 'TMOUT': '86400', 21:03:12 INFO - 'USER': 'cltbld', 21:03:12 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1475553034.378506-972252565', 21:03:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:03:12 INFO - '_': '/tools/buildbot/bin/python'} 21:03:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:03:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:03:12 INFO - Running setup.py (path:/tmp/pip-tNvH76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:03:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:03:12 INFO - Running setup.py (path:/tmp/pip-YT4ehu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:03:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:03:12 INFO - Running setup.py (path:/tmp/pip-qZV6F8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:03:13 INFO - Running setup.py (path:/tmp/pip-92pgMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:03:13 INFO - Running setup.py (path:/tmp/pip-D6OOup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:03:13 INFO - Running setup.py (path:/tmp/pip-mHOJqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:03:13 INFO - Running setup.py (path:/tmp/pip-ccBRe2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:03:13 INFO - Running setup.py (path:/tmp/pip-RrM1gs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:03:13 INFO - Running setup.py (path:/tmp/pip-837uo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:03:13 INFO - Running setup.py (path:/tmp/pip-qe04Cs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:03:13 INFO - Running setup.py (path:/tmp/pip-L7Fd2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:03:13 INFO - Running setup.py (path:/tmp/pip-B6jKIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:03:13 INFO - Running setup.py (path:/tmp/pip-Q6E67y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:03:13 INFO - Running setup.py (path:/tmp/pip-Gzp5Lu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:03:13 INFO - Running setup.py (path:/tmp/pip-G27S4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:03:13 INFO - Running setup.py (path:/tmp/pip-znYuhR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:03:13 INFO - Running setup.py (path:/tmp/pip-fgp89X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:03:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:03:14 INFO - Running setup.py install for manifestparser 21:03:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:03:14 INFO - Running setup.py install for mozcrash 21:03:14 INFO - Running setup.py install for mozdebug 21:03:14 INFO - Running setup.py install for mozdevice 21:03:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:03:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:03:14 INFO - Running setup.py install for mozfile 21:03:14 INFO - Running setup.py install for mozhttpd 21:03:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:03:14 INFO - Running setup.py install for mozinfo 21:03:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:03:14 INFO - Running setup.py install for mozInstall 21:03:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:03:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:03:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:03:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:03:14 INFO - Running setup.py install for mozleak 21:03:14 INFO - Running setup.py install for mozlog 21:03:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:03:15 INFO - Running setup.py install for moznetwork 21:03:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:03:15 INFO - Running setup.py install for mozprocess 21:03:15 INFO - Running setup.py install for mozprofile 21:03:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:03:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:03:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:03:15 INFO - Running setup.py install for mozrunner 21:03:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:03:15 INFO - Running setup.py install for mozscreenshot 21:03:15 INFO - Running setup.py install for moztest 21:03:15 INFO - Running setup.py install for mozversion 21:03:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:03:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:03:15 INFO - Cleaning up... 21:03:15 INFO - Return code: 0 21:03:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:03:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:03:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:03:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:03:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:03:15 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 0x7f5f00d86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1060ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105df60>, '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 0x105ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f1d0>, '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': '4300f881736b422476174874000001bc-1475553034.378506-972252565', '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 21:03:15 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 21:03:15 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 21:03:15 INFO - Using env: {'DISPLAY': ':0', 21:03:15 INFO - 'HOME': '/home/cltbld', 21:03:15 INFO - 'LANG': 'en_US.UTF-8', 21:03:15 INFO - 'LANGUAGE': 'en_US:en', 21:03:15 INFO - 'LOGNAME': 'cltbld', 21:03:15 INFO - 'MAIL': '/var/mail/cltbld', 21:03:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:03:15 INFO - 'MOZ_NO_REMOTE': '1', 21:03:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:03:15 INFO - 'NO_EM_RESTART': '1', 21:03:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:03:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:03:15 INFO - 'PWD': '/builds/slave/test', 21:03:15 INFO - 'SHELL': '/bin/bash', 21:03:15 INFO - 'SHLVL': '1', 21:03:15 INFO - 'TERM': 'linux', 21:03:15 INFO - 'TMOUT': '86400', 21:03:15 INFO - 'USER': 'cltbld', 21:03:15 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1475553034.378506-972252565', 21:03:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:03:15 INFO - '_': '/tools/buildbot/bin/python'} 21:03:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:03:16 INFO - Running setup.py (path:/tmp/pip-l4UPBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:03:16 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)) 21:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:03:16 INFO - Running setup.py (path:/tmp/pip-v96_0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:03:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:03:16 INFO - Running setup.py (path:/tmp/pip-zKZRiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:03:16 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)) 21:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:03:16 INFO - Running setup.py (path:/tmp/pip-lfgaY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:03:16 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)) 21:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:03:16 INFO - Running setup.py (path:/tmp/pip-vsG_Fm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:03:16 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)) 21:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:03:16 INFO - Running setup.py (path:/tmp/pip-jaCdl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:03:16 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)) 21:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:03:16 INFO - Running setup.py (path:/tmp/pip-IifLpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:03:16 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)) 21:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:03:16 INFO - Running setup.py (path:/tmp/pip-VpLWRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:03:16 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)) 21:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:03:16 INFO - Running setup.py (path:/tmp/pip-dtvslc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:03:16 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)) 21:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:03:16 INFO - Running setup.py (path:/tmp/pip-sqZMQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:03:16 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)) 21:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:03:16 INFO - Running setup.py (path:/tmp/pip-BQWK6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:03:16 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)) 21:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:03:16 INFO - Running setup.py (path:/tmp/pip-cWNYQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:03:16 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)) 21:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:03:16 INFO - Running setup.py (path:/tmp/pip-ywAhhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:03:17 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)) 21:03:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:03:17 INFO - Running setup.py (path:/tmp/pip-U9Rr_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:03:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:03:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:03:17 INFO - Running setup.py (path:/tmp/pip-ByIn0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:03:17 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)) 21:03:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:03:17 INFO - Running setup.py (path:/tmp/pip-mNF5P9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:03:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:03:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:03:17 INFO - Running setup.py (path:/tmp/pip-rY7Uat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:03:17 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)) 21:03:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:03:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:03:17 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)) 21:03:17 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)) 21:03:17 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)) 21:03:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:03:17 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 21:03:17 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 21:03:17 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 21:03:17 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 21:03:17 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 21:03:17 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 21:03:19 INFO - Downloading blessings-1.6.tar.gz 21:03:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:03:19 INFO - Installing collected packages: blessings 21:03:19 INFO - Running setup.py install for blessings 21:03:19 INFO - Successfully installed blessings 21:03:19 INFO - Cleaning up... 21:03:19 INFO - Return code: 0 21:03:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:03:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:03:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:03:19 INFO - Reading from file tmpfile_stdout 21:03:19 INFO - Current package versions: 21:03:19 INFO - argparse == 1.2.1 21:03:19 INFO - blessings == 1.6 21:03:19 INFO - blobuploader == 1.2.4 21:03:19 INFO - docopt == 0.6.1 21:03:19 INFO - functools32 == 3.2.3-2 21:03:19 INFO - jsonschema == 2.5.1 21:03:19 INFO - manifestparser == 1.1 21:03:19 INFO - mozInstall == 1.12 21:03:19 INFO - mozcrash == 0.17 21:03:19 INFO - mozdebug == 0.1 21:03:19 INFO - mozdevice == 0.48 21:03:19 INFO - mozfile == 1.2 21:03:19 INFO - mozhttpd == 0.7 21:03:19 INFO - mozinfo == 0.9 21:03:19 INFO - mozleak == 0.1 21:03:19 INFO - mozlog == 3.4 21:03:19 INFO - moznetwork == 0.27 21:03:19 INFO - mozprocess == 0.23 21:03:19 INFO - mozprofile == 0.28 21:03:19 INFO - mozrunner == 6.12 21:03:19 INFO - mozscreenshot == 0.1 21:03:19 INFO - mozsystemmonitor == 0.3 21:03:19 INFO - moztest == 0.7 21:03:19 INFO - mozversion == 1.4 21:03:19 INFO - psutil == 3.1.1 21:03:19 INFO - requests == 1.2.3 21:03:19 INFO - wsgiref == 0.1.2 21:03:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:03:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:03:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:03:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:03:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:03:19 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 0x7f5f00d86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1060ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105df60>, '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 0x105ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f1d0>, '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': '4300f881736b422476174874000001bc-1475553034.378506-972252565', '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 21:03:19 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 21:03:19 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 21:03:19 INFO - Using env: {'DISPLAY': ':0', 21:03:19 INFO - 'HOME': '/home/cltbld', 21:03:19 INFO - 'LANG': 'en_US.UTF-8', 21:03:19 INFO - 'LANGUAGE': 'en_US:en', 21:03:19 INFO - 'LOGNAME': 'cltbld', 21:03:19 INFO - 'MAIL': '/var/mail/cltbld', 21:03:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:03:19 INFO - 'MOZ_NO_REMOTE': '1', 21:03:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:03:19 INFO - 'NO_EM_RESTART': '1', 21:03:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:03:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:03:19 INFO - 'PWD': '/builds/slave/test', 21:03:19 INFO - 'SHELL': '/bin/bash', 21:03:19 INFO - 'SHLVL': '1', 21:03:19 INFO - 'TERM': 'linux', 21:03:19 INFO - 'TMOUT': '86400', 21:03:19 INFO - 'USER': 'cltbld', 21:03:19 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1475553034.378506-972252565', 21:03:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:03:19 INFO - '_': '/tools/buildbot/bin/python'} 21:03:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:03:19 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)) 21:03:19 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)) 21:03:19 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)) 21:03:19 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)) 21:03:19 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)) 21:03:19 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)) 21:03:19 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)) 21:03:19 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)) 21:03:19 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)) 21:03:19 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)) 21:03:19 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)) 21:03:19 INFO - Cleaning up... 21:03:19 INFO - Return code: 0 21:03:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:03:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:03:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:03:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:03:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:03:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5f00d86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1060ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105df60>, '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 0x105ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f1d0>, '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': '4300f881736b422476174874000001bc-1475553034.378506-972252565', '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 21:03:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:03:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:03:19 INFO - Using env: {'DISPLAY': ':0', 21:03:19 INFO - 'HOME': '/home/cltbld', 21:03:19 INFO - 'LANG': 'en_US.UTF-8', 21:03:19 INFO - 'LANGUAGE': 'en_US:en', 21:03:19 INFO - 'LOGNAME': 'cltbld', 21:03:19 INFO - 'MAIL': '/var/mail/cltbld', 21:03:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:03:19 INFO - 'MOZ_NO_REMOTE': '1', 21:03:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:03:19 INFO - 'NO_EM_RESTART': '1', 21:03:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:03:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:03:19 INFO - 'PWD': '/builds/slave/test', 21:03:19 INFO - 'SHELL': '/bin/bash', 21:03:19 INFO - 'SHLVL': '1', 21:03:19 INFO - 'TERM': 'linux', 21:03:19 INFO - 'TMOUT': '86400', 21:03:19 INFO - 'USER': 'cltbld', 21:03:19 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1475553034.378506-972252565', 21:03:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:03:19 INFO - '_': '/tools/buildbot/bin/python'} 21:03:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:03:20 INFO - Cleaning up... 21:03:20 INFO - Return code: 0 21:03:20 INFO - Running post-action listener: _resource_record_post_action 21:03:20 INFO - Running post-action listener: _start_resource_monitoring 21:03:20 INFO - Starting resource monitoring. 21:03:20 INFO - [mozharness: 2016-10-04 04:03:20.204015Z] Finished create-virtualenv step (success) 21:03:20 INFO - [mozharness: 2016-10-04 04:03:20.204476Z] Running install step. 21:03:20 INFO - Running pre-action listener: _resource_record_pre_action 21:03:20 INFO - Running main action method: install 21:03:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:03:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:03:20 INFO - Reading from file tmpfile_stdout 21:03:20 INFO - Detecting whether we're running mozinstall >=1.0... 21:03:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:03:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:03:20 INFO - Reading from file tmpfile_stdout 21:03:20 INFO - Output received: 21:03:20 INFO - Usage: mozinstall [options] installer 21:03:20 INFO - Options: 21:03:20 INFO - -h, --help show this help message and exit 21:03:20 INFO - -d DEST, --destination=DEST 21:03:20 INFO - Directory to install application into. [default: 21:03:20 INFO - "/builds/slave/test"] 21:03:20 INFO - --app=APP Application being installed. [default: firefox] 21:03:20 INFO - mkdir: /builds/slave/test/build/application 21:03:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:03:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:03:36 INFO - Reading from file tmpfile_stdout 21:03:36 INFO - Output received: 21:03:36 INFO - /builds/slave/test/build/application/firefox/firefox 21:03:36 INFO - Running post-action listener: _resource_record_post_action 21:03:36 INFO - [mozharness: 2016-10-04 04:03:36.636142Z] Finished install step (success) 21:03:36 INFO - [mozharness: 2016-10-04 04:03:36.636388Z] Running run-tests step. 21:03:36 INFO - Running pre-action listener: _resource_record_pre_action 21:03:36 INFO - Running main action method: run_tests 21:03:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:03:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:03:36 INFO - Python 2.7.3 21:03:36 INFO - Return code: 0 21:03:36 INFO - grabbing minidump binary from tooltool 21:03: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')]} 21:03:36 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 0x105df60>, '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 0x105ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:03:36 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 21:03:36 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 21:03:36 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 21:03:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:03:36 INFO - Return code: 0 21:03:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:03:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:03:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:03:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:03:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:03:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Rm8dUGc_TgijMxFkv85BwA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 21:03:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Rm8dUGc_TgijMxFkv85BwA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 21:03:36 INFO - Using env: {'DISPLAY': ':0', 21:03:36 INFO - 'HOME': '/home/cltbld', 21:03:36 INFO - 'LANG': 'en_US.UTF-8', 21:03:36 INFO - 'LANGUAGE': 'en_US:en', 21:03:36 INFO - 'LOGNAME': 'cltbld', 21:03:36 INFO - 'MAIL': '/var/mail/cltbld', 21:03:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:03:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:03:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:03:36 INFO - 'MOZ_NO_REMOTE': '1', 21:03:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:03:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:03:36 INFO - 'NO_EM_RESTART': '1', 21:03:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:03:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:03:36 INFO - 'PWD': '/builds/slave/test', 21:03:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:03:36 INFO - 'SHELL': '/bin/bash', 21:03:36 INFO - 'SHLVL': '1', 21:03:36 INFO - 'TERM': 'linux', 21:03:36 INFO - 'TMOUT': '86400', 21:03:36 INFO - 'USER': 'cltbld', 21:03:36 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1475553034.378506-972252565', 21:03:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:03:36 INFO - '_': '/tools/buildbot/bin/python'} 21:03:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Rm8dUGc_TgijMxFkv85BwA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 21:03:36 INFO - mozversion application_buildid: 20161003200701 21:03:36 INFO - mozversion application_changeset: adb484f84dec4b9d6a216ef3f4e1887fc3ae8084 21:03:36 INFO - mozversion application_display_name: Nightly 21:03:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:03:36 INFO - mozversion application_name: Firefox 21:03:36 INFO - mozversion application_remotingname: firefox 21:03:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:03:36 INFO - mozversion application_vendor: Mozilla 21:03:36 INFO - mozversion application_version: 52.0a1 21:03:36 INFO - mozversion platform_buildid: 20161003200701 21:03:36 INFO - mozversion platform_changeset: adb484f84dec4b9d6a216ef3f4e1887fc3ae8084 21:03:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:03:36 INFO - mozversion platform_version: 52.0a1 21:03:36 INFO - using testdate: 1475553816 21:03:36 INFO - actual date: 1475553816 21:03:36 INFO - starting webserver on 'localhost:49595' 21:03:36 INFO - SUITE-START | Running 2 tests 21:03:36 INFO - TEST-START | dromaeo_css 21:03:36 INFO - operating with platform_type : linux_ 21:03:36 INFO - Initialising browser for dromaeo_css test... 21:03:36 INFO - TEST-INFO | started process 7263 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMstcbY/profile http://localhost:49595/getInfo.html) 21:03:41 INFO - PROCESS | 7263 | __metrics Screen width/height:1600/1200 21:03:41 INFO - PROCESS | 7263 | colorDepth:24 21:03:41 INFO - PROCESS | 7263 | Browser inner width/height: 1024/697 21:03:41 INFO - PROCESS | 7263 | __metrics 21:03:42 INFO - PROCESS | 7263 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:03:42 INFO - PROCESS | 7263 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:03:42 INFO - PROCESS | 7263 | console.error: PushService: 21:03:42 INFO - PROCESS | 7263 | stateChangeProcessEnqueue: Error transitioning state 21:03:42 INFO - PROCESS | 7263 | UnknownError 21:03:43 INFO - TEST-INFO | 7263: exit 0 21:03:43 INFO - Browser initialized. 21:03:43 INFO - Running cycle 1/1 for dromaeo_css test... 21:03:43 INFO - TEST-INFO | started process 7343 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMstcbY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:03:55 INFO - PROCESS | 7343 | RSS: Main: 175648768 21:03:55 INFO - PROCESS | 7343 | 21:04:47 INFO - PROCESS | 7343 | 1475553887749 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 21:07:00 INFO - PROCESS | 7343 | Cycle 1(1): loaded http://localhost:49595/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49595/tests/dromaeo/cssquery-ext.html) 21:07:03 INFO - PROCESS | 7343 | RSS: Main: 395952128 21:07:03 INFO - PROCESS | 7343 | 21:10:05 INFO - PROCESS | 7343 | Cycle 1(1): loaded http://localhost:49595/tests/dromaeo/cssquery-ext.html (next: http://localhost:49595/tests/dromaeo/cssquery-jquery.html) 21:10:06 INFO - PROCESS | 7343 | RSS: Main: 278630400 21:10:06 INFO - PROCESS | 7343 | 21:13:08 INFO - PROCESS | 7343 | Cycle 1(1): loaded http://localhost:49595/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49595/tests/dromaeo/cssquery-mootools.html) 21:13:09 INFO - PROCESS | 7343 | RSS: Main: 219787264 21:13:09 INFO - PROCESS | 7343 | 21:16:11 INFO - PROCESS | 7343 | Cycle 1(1): loaded http://localhost:49595/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49595/tests/dromaeo/cssquery-prototype.html) 21:16:12 INFO - PROCESS | 7343 | RSS: Main: 220520448 21:16:12 INFO - PROCESS | 7343 | 21:19:15 INFO - PROCESS | 7343 | Cycle 1(1): loaded http://localhost:49595/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49595/tests/dromaeo/cssquery-yui.html) 21:19:15 INFO - PROCESS | 7343 | RSS: Main: 221708288 21:19:15 INFO - PROCESS | 7343 | 21:22:18 INFO - PROCESS | 7343 | Cycle 1(1): loaded http://localhost:49595/tests/dromaeo/cssquery-yui.html (next: http://localhost:49595/tests/dromaeo/cssquery-dojo.html) 21:22:19 INFO - PROCESS | 7343 | RSS: Main: 311746560 21:22:19 INFO - PROCESS | 7343 | 21:22:19 INFO - PROCESS | 7343 | __start_tp_report 21:22:19 INFO - PROCESS | 7343 | _x_x_mozilla_page_load 21:22:19 INFO - PROCESS | 7343 | _x_x_mozilla_page_load_details 21:22:19 INFO - PROCESS | 7343 | |i|pagename|runs| 21:22:19 INFO - PROCESS | 7343 | |0;dojo.html;2600.2849216465474;2600.5969074793406;2619.9214023579298;2657.202839148255;2669.8932042718293;4562.8631141065825;4646.3495110684535;4673.83641572545;4693.460252071013;4705.176594096032;4650.697704649196;4657.627389808816;4664.696794708341;4694.9765251173785;4715.85852424427;4250.04374015847;4261.424707664472;4301.462317210348;4304.956950430503;4406;4421.6904816662845;4431.64546836254;4432.312991486325;4451.77741112943;4461.375407442961;4226.746395216297;4268.231718290706;4361.280388735855;4393.978030109861;4422.933655995163;4312.9137417251795;4327.7619730914785;4330.350447432878;4333.349997500369;4334.393184954109;4313.525512193656;4318.762468064255;4321.956780432187;4323.2434323993175;4325.978370108161;4605.562471565196;4639.420072490939;4664.277037059262;4671.392718946549;4679.040796636681;4929.408470983505;4953.257011448276;5028.296038554606;5031.421386540558;5093.1850903855575;4839.975800121012;5059.443461219263;5071.112555302844;5080.695158290514;5139.922901156486;4550.021745324705;4586.243269860435;4627.629789616823;4656.860294191112;4677.555632214934;5164.845054648366;5173.172292433268;5179.689218646818;5180.9740951295;5222.529972302511;4940.604751619861;4962.478939711278;4965.354503914468;4972.105021096238;5026.547610715053;4861.440934292531;4918.508149185053;4976.7262800545595;4983.8006479741125;5029.547340739351;5003.624728145331;5003.774830132653;5043;5060.1903695408555;5069.518395752471;4960.032793605213;4963.528464795839;4965.47862474435;4967.60259179272;5034.773435195425;4139.089400331922;4168.6665066794585;4169.124483858363;4266.914661706748;4267.018585725301;3689.2252626948643;3705.981470092632;3711.03513086594;3721.0883333583447;3806.3909774435956;4369.694121411534;4374.62815660666;4377.321515165155;4418.248897687401;4425.977870110629;4862.051899879561;5010.674306170087;5030.622703297267;5033.899322013613;5038.79844806211;4286.892827679333;4313.611774940207;4341.826326946887;4344.54382289855;4390.209762242763;4513.526079761577;4517.887052823706;4522.412086428809;4535.7732113394195;4590.05903789729;4692.48382677912;4722.150012997762;4737.715737055788;4741.810327586858;4794.832180873653;4920.827771027997;4970.950290497049;4974.651774375759;5044.066847633199;5051.4443411225475;4738.123447162286;4763.404574428197;4764.475907650087;4764.880877978078;4765.785539650793;4952.331435256195;4958.652894297365;4961.08219979305;4962.45413004562;4965.230389289666;5031.094403007493;5039.319691841554;5039.84880453587;5040.319556859777;5045;4888.462269150462;4890.413150421972;4894.363732714724;4894.535019173173;4899.387576552931;4810.470848206624;4866.95133048665;4868.951310486991;4871.63462740303;4872.4640289567415;4797.496262892486;4798.304245884257;4833.299171620025;4842.951570484391;4853.708777473363;4970.403551573834;4971.2046072629655;4972.5276098770555;4977.701337919736;5018.824341148043;4664.230401983635;4713.6936099153445;4739.644526660445;4841.709497430165;4908.9754551227015 21:22:19 INFO - PROCESS | 7343 | |1;ext.html;543.5705792423985;566.4250785452766;573.6156774960779;589.0163427076783;594.2542109652386;37853;39697.4045389319;39938;43356.56643433565;43457.348139777925;39169.41245881314;39565.20869582607;39585.802070989674;39615.405768913486;39651.603483965155;7633.0458692663415;7778.5721785301785;7786.7663970080985;7786.8442631147345;7796.610169491531;7674.5395276283325;7763.184865589116;7772.183920688303;7773;7778.416618753616;7724.575148366837;7779.377649788032;7783.532988020708;7785.493942893722;7792.064952205715;7634.847303053935;7737.961310193441;7740.380769538423;7753.496022758559;7767.184445633184;7615.80960475987;7685.923140768577;7686.231376862325;7688.461807673465;7691.307782299564;37705.05737356561;38054.42918356227;38062;38123.80938095319;38166;2680.584509401046;2701.6757989041243;2963.2147480917574;3411.6929476347;3595.856165753367;26844.46311073787;28518.714812851813;28937.855310723313;28984.855075724696;29800.701992980008;3459.768290747513;3490.3542844573835;3522.3131489359585;3565.607783143852;3647.1611529348397;255966;256469;256862;256910;256957;31653;50512.49487505152;50548.74725626349;50829.745851270505;50836;31662.841685791424;33322.83338583291;33489.330213395595;33564.49653255203;33592.1601959953;12076.75846483083;12245.387730613435;12257.938710306391;12260.75478490443;12263.141580089487;9773.120419162167;9862.753431164278;9869.457179855177;9872.901270987342;9881.357711748857;7889.526628402315;7906.920930790733;7936.682532698743;8005.759827205193;8020.2781749641645;3079.4610943085318;3121.609798775153;3131.3111115554543;3158.210447388153;3229.3218424131196;827.4332082523491;926.8192702423098;926.893407258174;954.2032402943481;962.9951850240844;26856.731432685814;27205.72794272032;27462.725372746416;28002.43995120086;28536;908.336914052732;922.1009515722251;952.1858810716737;958.6884262614539;992.811365840488;14392;14661.780073298909;14685.870548770583;14760.63098422548;14981.925090374478;399626;402535;403950;404257;406510;48330.066797328414;49024;49057.50942490529;49091.263631045564;49165;1027.275770581738;1071.689210129054;1133.2180795251415;1142.126273400849;1145.4101137914147;27628;29028.419431611674;29238;29713.554296686;30152.396952061274;41468.377974331015;41730.582694173885;41822;41828.999999998785;41932.37101443542;298288;299333;300076;300102;300538;22532.098716051176;23176.4205894854;24135.51728965446;24441.38896527601;24588.139415120386;40747;41001.79499102486;41069;41146.794266028475;41205;34734.30531389409;35100.297994040484;35166.472502911965;35302;35939.46090808588;34978.125546860516;35329.82335088308;35471.467927980586;35667;35681.82159089188;33711;33892;34234.31531369408;34426;35042.29915401729;29818.850905745334;32106.51840222352;32199.839000804845;32345;32707.836460817543;24600.384990375383;24732.38169045788;24990.875045624656;25246.747532525176;25511.74488255168 21:22:19 INFO - PROCESS | 7343 | |2;jquery.html;366.5674504085179;367.7370679963827;369.31860716977167;383.3349139243414;386.1003861003861;15337.07977521348;16532.504024879257;16715.414960476384;16746.74879876803;16755.83244167558;16170.11064391458;16223.83776162238;16353.34586616537;16705.248263828125;16836.83163168368;4912.606991440685;5202.4277329493725;5203.349581302337;5206;5208.895822083556;3634.618365071669;3832.176082142339;4992.076465853828;5800.390958949313;6063.060225665007;6086.726097325609;6166.4450199482035;6168.475679567242;6172.321044685081;6184.103305020769;5930.288365396137;6121.908171377433;6136.509079273647;6147.999999999977;6149.354317796612;5207.270982062514;5304.549113325372;5397.8380648580605;5404.756785944642;5406.648567843117;20424.897875510527;20590;20642.690359644617;20673.896630516752;20762.48093797667;1728.887622304546;1909.4653497020856;2311.6879221305244;2437.878106094688;2453.77915987562;12639.241645501208;12844.550440734529;12882;13403.128796628189;13806.65483362914;1684.4020372767613;1774.9290028398848;1818;1830.9176087076114;1855.4248183063294;44861;65909.3409065908;65974.67012664906;67568.66215668939;69119;9077.228435583049;9267.629294828132;9295.953520232355;9303.25573954082;9892.55483503244;13322.400491977884;13339.73176571746;13346.265955372353;13349.799753003712;13350.933245333712;6439.967800161063;6505.21937367519;6544.8363790905605;6575.276719560845;6768.255491895888;5788.27646544182;5830.825075247664;5995.370486098984;6001.669908155093;6011.609245399035;5959.702014899324;6003.849903752441;6013.458788709037;6038.365971572922;6076.5442591805795;1542.2057640315247;1648.711475491784;1725.55998220453;1735.245168351771;1778.5731424458295;841.6979560900932;844.1811442900377;890.8040231149137;891.6700820696384;957.3203025851724;15874.126923019114;16660.001599616004;16742.665146696996;18200.271989120287;19363.32228372;816.5304949653972;827.1686954610698;859.5959898847532;863.2575984653193;867.3754896474528;9011.909880901107;9495.952520237355;9641.37331073492;9689.806203875884;9897.851532227023;367972;369017;370177;373938;394016;77299.22700773033;77890.6105469469;77983.8620979269;79437;79444.60277698575;869.8390797702446;909.3907082254905;915.3455279475207;928.0672923711627;929.2890938432105;11327.716807079889;14652.780208297097;15316.693666126392;16255.187240638157;16379;36857.07857303589;36967.630323696416;37091.629083708816;37778.62221377751;38125.61874381221;47040;48298.517014829406;48577.271340929205;50241.24638130504;50485.747571261905;4884.780184891617;5670.979223739601;6432.807015789534;7137.750178743719;7728.613569321624;11466.827997579876;11489.425528723363;11765.176437649283;11801.645950621494;11869.465874035863;9951.263402564353;10177.949110254698;10379.740506487096;10388.792224155324;10591.735206619896;10271;10329.328593641389;10344.793104137725;10465.9476702616;10704.411257380607;10097.798044038931;10308.639197628047;10496.947515262375;10505.632302869362;10564.947175264075;7412.444066695128;7469.551826890404;7505.512141710771;7648.694052238071;7752.8449431012195;8856.64573417056;10081.546330415002;10263.281570290306;10605.41670208146;10616.363018218932 21:22:19 INFO - PROCESS | 7343 | |3;mootools.html;1290.0324756432672;1340.7251513439746;1351.5269655620534;1606.4698649445684;1629.3482606957216;6509.674516274191;6743.662816859162;6975.965120174398;7635.961820190892;7640.503367281123;7119;7395.926040739591;7421.443391745614;7609.619519024054;7610.885836712454;2094.2251366994196;2115.3971118231307;2117.2483768262277;2120.7985241402043;2120.830333573318;2067.54514006919;2080.365488525999;2098.590774798915;2100.233414803601;2117.87292762434;2064.2878207018553;2067.328118361531;2067.390119914629;2085.593309304686;2093.874367537945;1935.6225536020481;1937.321937321926;1938.4572319750423;1945.085809669453;1946.8150525700037;1656.4202529114834;1722.6382459683482;1821.4444594398703;1897.1652472912012;1987.9105440255223;7230.27697230278;7515.436342274296;7528.8117797054965;7530.171681115073;7550.320471157567;4273.7008409411355;4389.5390983946545;4423.292273236299;4430.26900561407;4430.778461076933;2685.731426857318;2773.875175617082;2821.548552231633;2830.4197639483855;2832.702566230537;811.350919264586;812.5612169428501;828.1552816127517;829.1666874790857;831.4470876866876;10034.448105354202;10067.748306292327;10074.445905475195;10121.949390253001;10133.543990520371;3721.888343349704;3897.5322961244833;4018.4976877890263;4043.4945631796027;4045.9190816183514;8629.13708629132;8630.180132887366;8646.870296945552;8648.43785153963;8653.783655408539;4339.218940590661;4362.6946113772365;4374.431323927869;4376.124775045004;4376.627986621173;3917.764934103963;3977.5028121484816;3979.184267225212;3994.9201015979515;3997.240524300432;3212.9196770080935;3307.206270495064;3346.531485592019;3362.394768941565;3368.1579605098727;1034.384541197986;1035.9896401035894;1039.308859608352;1042.4318746283293;1042.7914417116608;608.3672980100646;691.6576294734139;748.5097261293861;773.3194788586009;790.7588185603446;4875.634327425457;4930.482299358588;4991.176455884738;5019.222020586815;5055.51972562606;814.7270664327398;845.6701886264361;852.5651917521984;854.9487030778173;860.4794099569796;3412.129906873731;3439.94840077399;3476.617572067071;3524.22467057247;3594.9281014379567;8222.506649601042;8673.6530538779;8680.8697869532;8681.131886811268;8687.087855775178;8377.790555236046;8435.789105272417;8626.525541095174;8647.827043459096;8655.956720216358;6802.387785099266;6967.756128535477;6968.477364197604;6969.895451568231;6971.128608923885;4777.355057067251;4985.92802547454;4995.8001679932395;5014.6991180529285;5049.141645920276;7923.801904952192;8135;8316.459430137022;8325.916740832756;8344.707935222237;8245.876311855207;8343.666253349798;8543.102974187621;8555.871661924952;8559.700410485602;6565.934340656532;6711.865762684816;6722.831929201809;6726.091977583159;6736.225334086643;6795.558288711218;6857.828554286183;6939.063226464363;7025.297470253138;7108;6219.471344935731;6259.843503912439;6305.5270854687;6320.083587879823;6582.17722784652;6037.366076562073;6054.3340232575265;6059.878802424015;6151.96924015377;6302.558820882494;5516.972415137899;5687.60186786921;5823.5923485355615;5887.882242355215;5891.263592050994;4148.564400738;4219.873403797891;4236.11041681238;4261.105167914772;4293.892652683708;4119.485064366954;4189.518205406417;4196.475440569929;4212.883585849813;4245.1085272093205 21:22:19 INFO - PROCESS | 7343 | |4;prototype.html;270.71033993626816;278.39310303538286;282.46331969258404;292.67074541141216;295.7471361985504;4831.173763348441;4847.951520484794;4851.757412129393;4854.320395144682;4855.198892182794;4756.406603787726;4785.090832741786;4789.928151077736;4793.3528973588645;4809.470958194595;3778.301014312361;3791.2227993261317;3791.4502397152396;3795.734298599099;3811.5426148862175;3803.6957043436596;3809.104860357814;3813;3828.540575130988;3854.730168888179;3634.418493041114;3746.4942232798494;3764.209516001643;3766.0961369271454;3769.321522126016;3764.4541541476606;3770.1517158639363;3774.3583590789767;3781.0925377909243;3783.1109689223013;3094.3037816491333;3332.8500217490273;3335.949960750591;3338.565986421774;3345.96654033459;4529.776960220722;4532.252178390561;4648.512476007679;4662.230731929228;4678.578927896471;4242.851500197478;4248.299030659938;4256.191323648497;4262.637675797561;4283.357496375568;4670.299455081765;4993.6005119590345;5011.942714943882;5016.272640467148;5018.723970181639;3280.2455435250026;3535.8762443314617;3556.484309775068;3561.715062794996;3564.1446052947367;5199.428062913076;5202.401723801736;5205.6876587404495;5206.114960456732;5209.843704688866;3631.2555926035097;3637.5998640149564;3641.708663306982;3644.325799727059;3655.3785856404475;3575.3385623659706;3668.523091998023;3671.3208056509097;3673;3711.294853977736;4200.684948628865;4203.47456567929;4204.66362690984;4206.72656277341;4214.599613036757;4971.757060734816;4975.875603109879;4978.701277923264;5004.974975125101;5017.172166592544;1237.7400745843295;1265.5380786013038;1285.4151361130664;1290.2065229883553;1291.5479582146174;799.9920100673194;816.3428440105772;834.7120243515977;836.7489753074053;838.6771093129189;3966.801659916993;3983.880483585497;3990.8204130814183;3997.340438827619;4043.7775922323967;4514.7291162530355;4528.705634133771;4542.5911667949385;4542.682012259176;4560.1335746208115;3940.8670107264793;3948.532167395378;3973.344398174269;3985.8405663773124;3996.540397854284;2410.722766881796;2414.227447216909;2576.755208255213;2785.916422507328;2793.8184018038764;4737.976310118427;4855.44162421319;4995.275685025651;5004.249362595567;5004.474530174352;5241.816536421207;5324.361076670824;5363.410024897258;5369.5972802040005;5399.4600539945695;4995.800167993312;4998.600111991032;4999.675086102186;5000.224965130411;5005.924911126409;5024.171011783015;5186.870328241824;5216.608754343515;5237.821490164835;5262.921056184084;5080.7229337078115;5128.410232823124;5131.307273518028;5136.922946155885;5139.511746384088;4977.8257760978195;4983.551480366785;4984.651074424755;4988.326575912205;4995.875103122451;3455.41257986148;3570.517980072657;3580.7672501287334;3611.331903597843;3637.1089083174793;5164.941187056719;5171.922421163761;5198.4801519847715;5202.583793296603;5207.2449494823795;5057.861981054233;5060.342155519759;5061.39263288393;5061.392632884077;5082.415522214993;4792.969511555032;5025.145725226647;5061.164907790173;5062.190049592047;5091.287219789307;4996.2755400466;4997.9500204997485;5002.52476014778;5003.874903127451;5004.1492946198505;5120.923186152137;5142.794288228429;5149.9742501287255;5176.4305926348825;5183.844484665316;4799.832005879777;4993.1012417763695;4994.200927851526;5002.574781143643;5043 21:22:19 INFO - PROCESS | 7343 | |5;yui.html;528.3026405145209;561.320801829786;586.5454272938473;604.5767962426303;646.3471893387677;12047.337396443203;12411.255324680526;12890.033247506428;12940.74118517629;12961.222326660396;12252.877471225285;12268.447919843606;12353.567625133122;12366.752664946718;12376.938115309433;747.5738828867547;765.1888997662468;769.4037121231034;771.1440301265591;771.4098714483424;615.5168192968521;631.7567736421488;745.8359160984575;768.2624680306913;775.0699161006786;810.4569938141459;811.8985126859143;812.4353574265888;812.6018251056998;813.0527934955769;799.7960520067346;800.4356928365488;800.8718605023197;801.0507548554981;801.4510060608472;473.9928901066487;479.3911732100213;568.5338022821288;584.1763114009227;588.8616175198824;11591.478383472764;11605.709857253552;11636.592719254786;11640.06879449642;11647.6505704829;11108.888911110866;11759.51887923427;11846.111541634325;11946.402679865972;12453.439595218237;11052.281601695944;11106.44467776608;11171.16216283782;11172.832407513893;11336.829947550794;3961.2473630010204;3981.124152686404;3984.5218573771044;4077.184563087365;4085.3259212229946;51738;53646.73176634131;53918.191227131625;61240;61287;9589.952050239704;9752.658656946973;9792.55933482995;9906;9982.550785214538;17530;17536.123193840256;17538.824611753975;17561.697384140967;17571.945683259044;6371.458426033839;6479.384458476437;6717.932820671828;6718.966405167943;6719;3318.9336213276083;3345.531625572422;3377.67912048355;3489.1102768793794;3512.438009918452;2672.078133044097;2775.0426102994434;2786;2788.2332358601143;2793.5530315149476;457.36883101319967;462.28576848768733;467.74975388167167;471.6886854675897;474.0211463328216;438.8924713445226;457.29119864211003;505.6561538154017;521.6557072332242;560.8289471711167;6975.3024697529845;7084.636692311078;7661.655225514865;7763.661625501089;8020.759377218576;536.841631718644;541.1044720986773;551.178743671926;561.6321309542175;568.7838621323871;3669.798161101165;3727.142757165813;3752.3058234226755;3860.2472517858746;3870.1679138985255;97029;101327.49336253271;101958;102811.48594256981;103035;39735.60264397319;48887.75556122268;48955.755221224375;49185;73656.89514657285;73822;74569.62715186497;74989.62505187439;75225;76604.61697691475;7472.813179670552;7805.14143444232;7853.921460785547;7878.960605196938;8133.34933205354;32637;40209.08964669035;41914.58085419229;43719.125617488105;44110.77944610385;63667;64647.67676161589;65079.67460162669;65537.34462655312;66362.33637663562;11159.27464714791;11357.375344355809;11369.090472761995;11703;11712.414379280832;12725.745485090432;12766.42551085222;12795.61613151607;13023.544175953795;13588;11195.44022798873;11231.4384280784;11295.039921606756;11307.151963602599;12169.939150304192;11256.268342557707;11351.886481135083;11946.880531194924;11976.341301228516;12353;12106.576269830866;12114.878851211375;12128.393580321124;12131.939340303243;12136.514539418678;9463.668771593237;9630.855537167088;9737.805243895224;9871.40771553709;10202.795944080928;8858.487892902749;9209.309301802527;9393.85909211376;9732.70801875945;10243.539040743333 21:22:19 INFO - PROCESS | 7343 | __end_tp_report 21:22:19 INFO - PROCESS | 7343 | __start_cc_report 21:22:19 INFO - PROCESS | 7343 | _x_x_mozilla_cycle_collect,2350 21:22:19 INFO - PROCESS | 7343 | __end_cc_report 21:22:19 INFO - PROCESS | 7343 | __startTimestamp1475554939033__endTimestamp 21:22:19 INFO - PROCESS | 7343 | 21:22:19 INFO - PROCESS | 7343 | ------- Summary: start ------- 21:22:19 INFO - PROCESS | 7343 | Number of tests: 6 21:22:19 INFO - PROCESS | 7343 | 21:22:19 INFO - PROCESS | 7343 | [#0] dojo.html Cycles:165 Average:4640.69 Median:4741.81 stddev:482.23 (10.2%) stddev-sans-first:456.38 21:22:19 INFO - PROCESS | 7343 | Values: 2600.3 2600.6 2619.9 2657.2 2669.9 4562.9 4646.3 4673.8 4693.5 4705.2 4650.7 4657.6 4664.7 4695.0 4715.9 4250.0 4261.4 4301.5 4305.0 4406.0 4421.7 4431.6 4432.3 4451.8 4461.4 4226.7 4268.2 4361.3 4394.0 4422.9 4312.9 4327.8 4330.4 4333.3 4334.4 4313.5 4318.8 4322.0 4323.2 4326.0 4605.6 4639.4 4664.3 4671.4 4679.0 4929.4 4953.3 5028.3 5031.4 5093.2 4840.0 5059.4 5071.1 5080.7 5139.9 4550.0 4586.2 4627.6 4656.9 4677.6 5164.8 5173.2 5179.7 5181.0 5222.5 4940.6 4962.5 4965.4 4972.1 5026.5 4861.4 4918.5 4976.7 4983.8 5029.5 5003.6 5003.8 5043.0 5060.2 5069.5 4960.0 4963.5 4965.5 4967.6 5034.8 4139.1 4168.7 4169.1 4266.9 4267.0 3689.2 3706.0 3711.0 3721.1 3806.4 4369.7 4374.6 4377.3 4418.2 4426.0 4862.1 5010.7 5030.6 5033.9 5038.8 4286.9 4313.6 4341.8 4344.5 4390.2 4513.5 4517.9 4522.4 4535.8 4590.1 4692.5 4722.2 4737.7 4741.8 4794.8 4920.8 4971.0 4974.7 5044.1 5051.4 4738.1 4763.4 4764.5 4764.9 4765.8 4952.3 4958.7 4961.1 4962.5 4965.2 5031.1 5039.3 5039.8 5040.3 5045.0 4888.5 4890.4 4894.4 4894.5 4899.4 4810.5 4867.0 4869.0 4871.6 4872.5 4797.5 4798.3 4833.3 4843.0 4853.7 4970.4 4971.2 4972.5 4977.7 5018.8 4664.2 4713.7 4739.6 4841.7 4909.0 21:22:19 INFO - PROCESS | 7343 | 21:22:19 INFO - PROCESS | 7343 | [#1] ext.html Cycles:180 Average:46040.13 Median:20676.11 stddev:86052.20 (416.2%) stddev-sans-first:86225.80 21:22:19 INFO - PROCESS | 7343 | Values: 543.6 566.4 573.6 589.0 594.3 37853.0 39697.4 39938.0 43356.6 43457.3 39169.4 39565.2 39585.8 39615.4 39651.6 7633.0 7778.6 7786.8 7786.8 7796.6 7674.5 7763.2 7772.2 7773.0 7778.4 7724.6 7779.4 7783.5 7785.5 7792.1 7634.8 7738.0 7740.4 7753.5 7767.2 7615.8 7685.9 7686.2 7688.5 7691.3 37705.1 38054.4 38062.0 38123.8 38166.0 2680.6 2701.7 2963.2 3411.7 3595.9 26844.5 28518.7 28937.9 28984.9 29800.7 3459.8 3490.4 3522.3 3565.6 3647.2 255966.0 256469.0 256862.0 256910.0 256957.0 31653.0 50512.5 50548.7 50829.7 50836.0 31662.8 33322.8 33489.3 33564.5 33592.2 12076.8 12245.4 12257.9 12260.8 12263.1 9773.1 9862.8 9869.5 9872.9 9881.4 7889.5 7906.9 7936.7 8005.8 8020.3 3079.5 3121.6 3131.3 3158.2 3229.3 827.4 926.8 926.9 954.2 963.0 26856.7 27205.7 27462.7 28002.4 28536.0 908.3 922.1 952.2 958.7 992.8 14392.0 14661.8 14685.9 14760.6 14981.9 399626.0 402535.0 403950.0 404257.0 406510.0 48330.1 49024.0 49057.5 49091.3 49165.0 1027.3 1071.7 1133.2 1142.1 1145.4 27628.0 29028.4 29238.0 29713.6 30152.4 41468.4 41730.6 41822.0 41829.0 41932.4 298288.0 299333.0 300076.0 300102.0 300538.0 22532.1 23176.4 24135.5 24441.4 24588.1 40747.0 41001.8 41069.0 41146.8 41205.0 34734.3 35100.3 35166.5 35302.0 35939.5 34978.1 35329.8 35471.5 35667.0 35681.8 33711.0 33892.0 34234.3 34426.0 35042.3 29818.9 32106.5 32199.8 32345.0 32707.8 24600.4 24732.4 24990.9 25246.7 25511.7 21:22:19 INFO - PROCESS | 7343 | 21:22:19 INFO - PROCESS | 7343 | [#2] jquery.html Cycles:180 Average:23750.70 Median:45950.50 stddev:61938.97 (134.8%) stddev-sans-first:62087.84 21:22:19 INFO - PROCESS | 7343 | Values: 366.6 367.7 369.3 383.3 386.1 15337.1 16532.5 16715.4 16746.7 16755.8 16170.1 16223.8 16353.3 16705.2 16836.8 4912.6 5202.4 5203.3 5206.0 5208.9 3634.6 3832.2 4992.1 5800.4 6063.1 6086.7 6166.4 6168.5 6172.3 6184.1 5930.3 6121.9 6136.5 6148.0 6149.4 5207.3 5304.5 5397.8 5404.8 5406.6 20424.9 20590.0 20642.7 20673.9 20762.5 1728.9 1909.5 2311.7 2437.9 2453.8 12639.2 12844.6 12882.0 13403.1 13806.7 1684.4 1774.9 1818.0 1830.9 1855.4 44861.0 65909.3 65974.7 67568.7 69119.0 9077.2 9267.6 9296.0 9303.3 9892.6 13322.4 13339.7 13346.3 13349.8 13350.9 6440.0 6505.2 6544.8 6575.3 6768.3 5788.3 5830.8 5995.4 6001.7 6011.6 5959.7 6003.8 6013.5 6038.4 6076.5 1542.2 1648.7 1725.6 1735.2 1778.6 841.7 844.2 890.8 891.7 957.3 15874.1 16660.0 16742.7 18200.3 19363.3 816.5 827.2 859.6 863.3 867.4 9011.9 9496.0 9641.4 9689.8 9897.9 367972.0 369017.0 370177.0 373938.0 394016.0 77299.2 77890.6 77983.9 79437.0 79444.6 869.8 909.4 915.3 928.1 929.3 11327.7 14652.8 15316.7 16255.2 16379.0 36857.1 36967.6 37091.6 37778.6 38125.6 47040.0 48298.5 48577.3 50241.2 50485.7 4884.8 5671.0 6432.8 7137.8 7728.6 11466.8 11489.4 11765.2 11801.6 11869.5 9951.3 10177.9 10379.7 10388.8 10591.7 10271.0 10329.3 10344.8 10465.9 10704.4 10097.8 10308.6 10496.9 10505.6 10564.9 7412.4 7469.6 7505.5 7648.7 7752.8 8856.6 10081.5 10263.3 10605.4 10616.4 21:22:19 INFO - PROCESS | 7343 | 21:22:19 INFO - PROCESS | 7343 | [#3] mootools.html Cycles:180 Average:4801.97 Median:5005.25 stddev:2677.79 (53.5%) stddev-sans-first:2672.30 21:22:19 INFO - PROCESS | 7343 | Values: 1290.0 1340.7 1351.5 1606.5 1629.3 6509.7 6743.7 6976.0 7636.0 7640.5 7119.0 7395.9 7421.4 7609.6 7610.9 2094.2 2115.4 2117.2 2120.8 2120.8 2067.5 2080.4 2098.6 2100.2 2117.9 2064.3 2067.3 2067.4 2085.6 2093.9 1935.6 1937.3 1938.5 1945.1 1946.8 1656.4 1722.6 1821.4 1897.2 1987.9 7230.3 7515.4 7528.8 7530.2 7550.3 4273.7 4389.5 4423.3 4430.3 4430.8 2685.7 2773.9 2821.5 2830.4 2832.7 811.4 812.6 828.2 829.2 831.4 10034.4 10067.7 10074.4 10121.9 10133.5 3721.9 3897.5 4018.5 4043.5 4045.9 8629.1 8630.2 8646.9 8648.4 8653.8 4339.2 4362.7 4374.4 4376.1 4376.6 3917.8 3977.5 3979.2 3994.9 3997.2 3212.9 3307.2 3346.5 3362.4 3368.2 1034.4 1036.0 1039.3 1042.4 1042.8 608.4 691.7 748.5 773.3 790.8 4875.6 4930.5 4991.2 5019.2 5055.5 814.7 845.7 852.6 854.9 860.5 3412.1 3439.9 3476.6 3524.2 3594.9 8222.5 8673.7 8680.9 8681.1 8687.1 8377.8 8435.8 8626.5 8647.8 8656.0 6802.4 6967.8 6968.5 6969.9 6971.1 4777.4 4985.9 4995.8 5014.7 5049.1 7923.8 8135.0 8316.5 8325.9 8344.7 8245.9 8343.7 8543.1 8555.9 8559.7 6565.9 6711.9 6722.8 6726.1 6736.2 6795.6 6857.8 6939.1 7025.3 7108.0 6219.5 6259.8 6305.5 6320.1 6582.2 6037.4 6054.3 6059.9 6152.0 6302.6 5517.0 5687.6 5823.6 5887.9 5891.3 4148.6 4219.9 4236.1 4261.1 4293.9 4119.5 4189.5 4196.5 4212.9 4245.1 21:22:19 INFO - PROCESS | 7343 | 21:22:19 INFO - PROCESS | 7343 | [#4] prototype.html Cycles:180 Average:4140.41 Median:4708.28 stddev:1223.87 (26.0%) stddev-sans-first:1192.34 21:22:19 INFO - PROCESS | 7343 | Values: 270.7 278.4 282.5 292.7 295.7 4831.2 4848.0 4851.8 4854.3 4855.2 4756.4 4785.1 4789.9 4793.4 4809.5 3778.3 3791.2 3791.5 3795.7 3811.5 3803.7 3809.1 3813.0 3828.5 3854.7 3634.4 3746.5 3764.2 3766.1 3769.3 3764.5 3770.2 3774.4 3781.1 3783.1 3094.3 3332.9 3335.9 3338.6 3346.0 4529.8 4532.3 4648.5 4662.2 4678.6 4242.9 4248.3 4256.2 4262.6 4283.4 4670.3 4993.6 5011.9 5016.3 5018.7 3280.2 3535.9 3556.5 3561.7 3564.1 5199.4 5202.4 5205.7 5206.1 5209.8 3631.3 3637.6 3641.7 3644.3 3655.4 3575.3 3668.5 3671.3 3673.0 3711.3 4200.7 4203.5 4204.7 4206.7 4214.6 4971.8 4975.9 4978.7 5005.0 5017.2 1237.7 1265.5 1285.4 1290.2 1291.5 800.0 816.3 834.7 836.7 838.7 3966.8 3983.9 3990.8 3997.3 4043.8 4514.7 4528.7 4542.6 4542.7 4560.1 3940.9 3948.5 3973.3 3985.8 3996.5 2410.7 2414.2 2576.8 2785.9 2793.8 4738.0 4855.4 4995.3 5004.2 5004.5 5241.8 5324.4 5363.4 5369.6 5399.5 4995.8 4998.6 4999.7 5000.2 5005.9 5024.2 5186.9 5216.6 5237.8 5262.9 5080.7 5128.4 5131.3 5136.9 5139.5 4977.8 4983.6 4984.7 4988.3 4995.9 3455.4 3570.5 3580.8 3611.3 3637.1 5164.9 5171.9 5198.5 5202.6 5207.2 5057.9 5060.3 5061.4 5061.4 5082.4 4793.0 5025.1 5061.2 5062.2 5091.3 4996.3 4998.0 5002.5 5003.9 5004.1 5120.9 5142.8 5150.0 5176.4 5183.8 4799.8 4993.1 4994.2 5002.6 5043.0 21:22:19 INFO - PROCESS | 7343 | 21:22:19 INFO - PROCESS | 7343 | [#5] yui.html Cycles:180 Average:16608.72 Median:465.02 stddev:23704.55 (5097.6%) stddev-sans-first:23740.29 21:22:19 INFO - PROCESS | 7343 | Values: 528.3 561.3 586.5 604.6 646.3 12047.3 12411.3 12890.0 12940.7 12961.2 12252.9 12268.4 12353.6 12366.8 12376.9 747.6 765.2 769.4 771.1 771.4 615.5 631.8 745.8 768.3 775.1 810.5 811.9 812.4 812.6 813.1 799.8 800.4 800.9 801.1 801.5 474.0 479.4 568.5 584.2 588.9 11591.5 11605.7 11636.6 11640.1 11647.7 11108.9 11759.5 11846.1 11946.4 12453.4 11052.3 11106.4 11171.2 11172.8 11336.8 3961.2 3981.1 3984.5 4077.2 4085.3 51738.0 53646.7 53918.2 61240.0 61287.0 9590.0 9752.7 9792.6 9906.0 9982.6 17530.0 17536.1 17538.8 17561.7 17571.9 6371.5 6479.4 6717.9 6719.0 6719.0 3318.9 3345.5 3377.7 3489.1 3512.4 2672.1 2775.0 2786.0 2788.2 2793.6 457.4 462.3 467.7 471.7 474.0 438.9 457.3 505.7 521.7 560.8 6975.3 7084.6 7661.7 7763.7 8020.8 536.8 541.1 551.2 561.6 568.8 3669.8 3727.1 3752.3 3860.2 3870.2 97029.0 101327.5 101958.0 102811.5 103035.0 39735.6 48887.8 48955.8 49185.0 73656.9 73822.0 74569.6 74989.6 75225.0 76604.6 7472.8 7805.1 7853.9 7879.0 8133.3 32637.0 40209.1 41914.6 43719.1 44110.8 63667.0 64647.7 65079.7 65537.3 66362.3 11159.3 11357.4 11369.1 11703.0 11712.4 12725.7 12766.4 12795.6 13023.5 13588.0 11195.4 11231.4 11295.0 11307.2 12169.9 11256.3 11351.9 11946.9 11976.3 12353.0 12106.6 12114.9 12128.4 12131.9 12136.5 9463.7 9630.9 9737.8 9871.4 10202.8 8858.5 9209.3 9393.9 9732.7 10243.5 21:22:19 INFO - PROCESS | 7343 | -------- Summary: end -------- 21:22:19 INFO - PROCESS | 7343 | 21:22:20 INFO - TEST-INFO | 7343: exit 0 21:22:20 INFO - TEST-OK | dromaeo_css | took 1123118ms 21:22:20 INFO - TEST-START | kraken 21:22:20 INFO - operating with platform_type : linux_ 21:22:20 INFO - Initialising browser for kraken test... 21:22:20 INFO - TEST-INFO | started process 7652 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGj5iGw/profile http://localhost:49595/getInfo.html) 21:22:24 INFO - PROCESS | 7652 | __metrics Screen width/height:1600/1200 21:22:24 INFO - PROCESS | 7652 | colorDepth:24 21:22:24 INFO - PROCESS | 7652 | Browser inner width/height: 1024/697 21:22:24 INFO - PROCESS | 7652 | __metrics 21:22:25 INFO - PROCESS | 7652 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:22:25 INFO - PROCESS | 7652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:22:25 INFO - PROCESS | 7652 | console.error: PushService: 21:22:25 INFO - PROCESS | 7652 | stateChangeProcessEnqueue: Error transitioning state 21:22:25 INFO - PROCESS | 7652 | UnknownError 21:22:26 INFO - TEST-INFO | 7652: exit 0 21:22:26 INFO - Browser initialized. 21:22:26 INFO - Running cycle 1/1 for kraken test... 21:22:26 INFO - TEST-INFO | started process 7735 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGj5iGw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:22:38 INFO - PROCESS | 7735 | RSS: Main: 175665152 21:22:38 INFO - PROCESS | 7735 | 21:22:41 INFO - PROCESS | 7735 | Cycle 1(1): loaded http://localhost:49595/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49595/tests/kraken/driver.html?testName=audio-beat-detection) 21:22:42 INFO - PROCESS | 7735 | RSS: Main: 238796800 21:22:42 INFO - PROCESS | 7735 | 21:22:45 INFO - PROCESS | 7735 | Cycle 1(1): loaded http://localhost:49595/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49595/tests/kraken/driver.html?testName=audio-dft) 21:22:45 INFO - PROCESS | 7735 | RSS: Main: 219201536 21:22:45 INFO - PROCESS | 7735 | 21:22:49 INFO - PROCESS | 7735 | Cycle 1(1): loaded http://localhost:49595/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49595/tests/kraken/driver.html?testName=audio-fft) 21:22:49 INFO - PROCESS | 7735 | RSS: Main: 301060096 21:22:49 INFO - PROCESS | 7735 | 21:22:52 INFO - PROCESS | 7735 | Cycle 1(1): loaded http://localhost:49595/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49595/tests/kraken/driver.html?testName=audio-oscillator) 21:22:52 INFO - PROCESS | 7735 | RSS: Main: 211947520 21:22:52 INFO - PROCESS | 7735 | 21:22:54 INFO - PROCESS | 7735 | Cycle 1(1): loaded http://localhost:49595/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49595/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:22:55 INFO - PROCESS | 7735 | RSS: Main: 214687744 21:22:55 INFO - PROCESS | 7735 | 21:22:58 INFO - PROCESS | 7735 | Cycle 1(1): loaded http://localhost:49595/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49595/tests/kraken/driver.html?testName=imaging-darkroom) 21:22:59 INFO - PROCESS | 7735 | RSS: Main: 251736064 21:22:59 INFO - PROCESS | 7735 | 21:23:02 INFO - PROCESS | 7735 | Cycle 1(1): loaded http://localhost:49595/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49595/tests/kraken/driver.html?testName=imaging-desaturate) 21:23:03 INFO - PROCESS | 7735 | RSS: Main: 249929728 21:23:03 INFO - PROCESS | 7735 | 21:23:06 INFO - PROCESS | 7735 | Cycle 1(1): loaded http://localhost:49595/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49595/tests/kraken/driver.html?testName=json-parse-financial) 21:23:06 INFO - PROCESS | 7735 | RSS: Main: 249823232 21:23:06 INFO - PROCESS | 7735 | 21:23:08 INFO - PROCESS | 7735 | Cycle 1(1): loaded http://localhost:49595/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49595/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:23:09 INFO - PROCESS | 7735 | RSS: Main: 212721664 21:23:09 INFO - PROCESS | 7735 | 21:23:11 INFO - PROCESS | 7735 | Cycle 1(1): loaded http://localhost:49595/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49595/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:23:11 INFO - PROCESS | 7735 | RSS: Main: 219848704 21:23:11 INFO - PROCESS | 7735 | 21:23:13 INFO - PROCESS | 7735 | Cycle 1(1): loaded http://localhost:49595/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49595/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:23:14 INFO - PROCESS | 7735 | RSS: Main: 229216256 21:23:14 INFO - PROCESS | 7735 | 21:23:17 INFO - PROCESS | 7735 | Cycle 1(1): loaded http://localhost:49595/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49595/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:23:18 INFO - PROCESS | 7735 | RSS: Main: 237232128 21:23:18 INFO - PROCESS | 7735 | 21:23:21 INFO - PROCESS | 7735 | Cycle 1(1): loaded http://localhost:49595/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49595/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:23:21 INFO - PROCESS | 7735 | RSS: Main: 233701376 21:23:21 INFO - PROCESS | 7735 | 21:23:23 INFO - PROCESS | 7735 | Cycle 1(1): loaded http://localhost:49595/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49595/tests/kraken/driver.html?testName=ai-astar) 21:23:23 INFO - PROCESS | 7735 | RSS: Main: 285728768 21:23:23 INFO - PROCESS | 7735 | 21:23:23 INFO - PROCESS | 7735 | __start_tp_report 21:23:23 INFO - PROCESS | 7735 | _x_x_mozilla_page_load 21:23:23 INFO - PROCESS | 7735 | _x_x_mozilla_page_load_details 21:23:23 INFO - PROCESS | 7735 | |i|pagename|runs| 21:23:23 INFO - PROCESS | 7735 | |0;ai-astar;114;117;116;116;116;116;113;114;115;115 21:23:23 INFO - PROCESS | 7735 | |1;audio-beat-detection;153;129;131;171;139;129;137;126;172;132 21:23:23 INFO - PROCESS | 7735 | |2;audio-dft;163;164;163;163;161;159;160;164;164;161 21:23:23 INFO - PROCESS | 7735 | |3;audio-fft;76;77;77;107;77;79;78;78;107;77 21:23:23 INFO - PROCESS | 7735 | |4;audio-oscillator;86;85;113;84;85;84;111;84;83;120 21:23:23 INFO - PROCESS | 7735 | |5;imaging-gaussian-blur;117;117;117;118;118;118;117;118;120;116 21:23:23 INFO - PROCESS | 7735 | |6;imaging-darkroom;147;147;146;147;145;146;146;147;146;145 21:23:23 INFO - PROCESS | 7735 | |7;imaging-desaturate;95;95;95;96;96;95;95;95;95;95 21:23:23 INFO - PROCESS | 7735 | |8;json-parse-financial;64;63;63;64;63;65;64;65;64;65 21:23:23 INFO - PROCESS | 7735 | |9;json-stringify-tinderbox;66;67;67;66;67;65;66;66;66;72 21:23:23 INFO - PROCESS | 7735 | |10;stanford-crypto-aes;90;82;82;84;83;83;83;83;82;83 21:23:23 INFO - PROCESS | 7735 | |11;stanford-crypto-ccm;141;140;140;156;138;155;138;137;176;138 21:23:23 INFO - PROCESS | 7735 | |12;stanford-crypto-pbkdf2;179;174;174;176;173;171;176;178;177;172 21:23:23 INFO - PROCESS | 7735 | |13;stanford-crypto-sha256-iterative;69;70;71;73;70;79;72;70;70;68 21:23:23 INFO - PROCESS | 7735 | __end_tp_report 21:23:23 INFO - PROCESS | 7735 | __start_cc_report 21:23:23 INFO - PROCESS | 7735 | _x_x_mozilla_cycle_collect,1929 21:23:23 INFO - PROCESS | 7735 | __end_cc_report 21:23:23 INFO - PROCESS | 7735 | __startTimestamp1475555003741__endTimestamp 21:23:23 INFO - PROCESS | 7735 | 21:23:23 INFO - PROCESS | 7735 | ------- Summary: start ------- 21:23:23 INFO - PROCESS | 7735 | Number of tests: 14 21:23:23 INFO - PROCESS | 7735 | 21:23:23 INFO - PROCESS | 7735 | [#0] ai-astar Cycles:10 Average:115.20 Median:116.00 stddev:1.23 (1.1%) stddev-sans-first:1.22 21:23:23 INFO - PROCESS | 7735 | Values: 114.0 117.0 116.0 116.0 116.0 116.0 113.0 114.0 115.0 115.0 21:23:23 INFO - PROCESS | 7735 | 21:23:23 INFO - PROCESS | 7735 | [#1] audio-beat-detection Cycles:10 Average:141.90 Median:138.00 stddev:17.36 (12.6%) stddev-sans-first:17.94 21:23:23 INFO - PROCESS | 7735 | Values: 153.0 129.0 131.0 171.0 139.0 129.0 137.0 126.0 172.0 132.0 21:23:23 INFO - PROCESS | 7735 | 21:23:23 INFO - PROCESS | 7735 | [#2] audio-dft Cycles:10 Average:162.20 Median:163.00 stddev:1.81 (1.1%) stddev-sans-first:1.90 21:23:23 INFO - PROCESS | 7735 | Values: 163.0 164.0 163.0 163.0 161.0 159.0 160.0 164.0 164.0 161.0 21:23:23 INFO - PROCESS | 7735 | 21:23:23 INFO - PROCESS | 7735 | [#3] audio-fft Cycles:10 Average:83.30 Median:77.00 stddev:12.52 (16.3%) stddev-sans-first:12.99 21:23:23 INFO - PROCESS | 7735 | Values: 76.0 77.0 77.0 107.0 77.0 79.0 78.0 78.0 107.0 77.0 21:23:23 INFO - PROCESS | 7735 | 21:23:23 INFO - PROCESS | 7735 | [#4] audio-oscillator Cycles:10 Average:93.50 Median:84.00 stddev:14.80 (17.6%) stddev-sans-first:15.44 21:23:23 INFO - PROCESS | 7735 | Values: 86.0 85.0 113.0 84.0 85.0 84.0 111.0 84.0 83.0 120.0 21:23:23 INFO - PROCESS | 7735 | 21:23:23 INFO - PROCESS | 7735 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:1.07 (0.9%) stddev-sans-first:1.12 21:23:23 INFO - PROCESS | 7735 | Values: 117.0 117.0 117.0 118.0 118.0 118.0 117.0 118.0 120.0 116.0 21:23:23 INFO - PROCESS | 7735 | 21:23:23 INFO - PROCESS | 7735 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 21:23:23 INFO - PROCESS | 7735 | Values: 147.0 147.0 146.0 147.0 145.0 146.0 146.0 147.0 146.0 145.0 21:23:23 INFO - PROCESS | 7735 | 21:23:23 INFO - PROCESS | 7735 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 21:23:23 INFO - PROCESS | 7735 | Values: 95.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 21:23:23 INFO - PROCESS | 7735 | 21:23:23 INFO - PROCESS | 7735 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:64.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 21:23:23 INFO - PROCESS | 7735 | Values: 64.0 63.0 63.0 64.0 63.0 65.0 64.0 65.0 64.0 65.0 21:23:23 INFO - PROCESS | 7735 | 21:23:23 INFO - PROCESS | 7735 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:66.50 stddev:1.93 (2.9%) stddev-sans-first:2.03 21:23:23 INFO - PROCESS | 7735 | Values: 66.0 67.0 67.0 66.0 67.0 65.0 66.0 66.0 66.0 72.0 21:23:23 INFO - PROCESS | 7735 | 21:23:23 INFO - PROCESS | 7735 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:83.00 stddev:2.37 (2.9%) stddev-sans-first:0.67 21:23:23 INFO - PROCESS | 7735 | Values: 90.0 82.0 82.0 84.0 83.0 83.0 83.0 83.0 82.0 83.0 21:23:23 INFO - PROCESS | 7735 | 21:23:23 INFO - PROCESS | 7735 | [#11] stanford-crypto-ccm Cycles:10 Average:145.90 Median:140.50 stddev:12.70 (9.0%) stddev-sans-first:13.34 21:23:23 INFO - PROCESS | 7735 | Values: 141.0 140.0 140.0 156.0 138.0 155.0 138.0 137.0 176.0 138.0 21:23:23 INFO - PROCESS | 7735 | 21:23:23 INFO - PROCESS | 7735 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.00 Median:176.00 stddev:2.62 (1.5%) stddev-sans-first:2.35 21:23:23 INFO - PROCESS | 7735 | Values: 179.0 174.0 174.0 176.0 173.0 171.0 176.0 178.0 177.0 172.0 21:23:23 INFO - PROCESS | 7735 | 21:23:23 INFO - PROCESS | 7735 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.20 Median:70.50 stddev:3.08 (4.4%) stddev-sans-first:3.17 21:23:23 INFO - PROCESS | 7735 | Values: 69.0 70.0 71.0 73.0 70.0 79.0 72.0 70.0 70.0 68.0 21:23:23 INFO - PROCESS | 7735 | -------- Summary: end -------- 21:23:23 INFO - PROCESS | 7735 | 21:23:25 INFO - TEST-INFO | 7735: exit 0 21:23:25 INFO - TEST-OK | kraken | took 65088ms 21:23:25 INFO - SUITE-END | took 1188s 21:23:25 INFO - Completed test suite (00:19:48) 21:23:25 INFO - javascript benchmark 21:23:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2600.2849216465474, 2600.5969074793406, 2619.9214023579298, 2657.202839148255, 2669.8932042718293, 4562.8631141065825, 4646.3495110684535, 4673.83641572545, 4693.460252071013, 4705.176594096032, 4650.697704649196, 4657.627389808816, 4664.696794708341, 4694.9765251173785, 4715.85852424427, 4250.04374015847, 4261.424707664472, 4301.462317210348, 4304.956950430503, 4406.0, 4421.6904816662845, 4431.64546836254, 4432.312991486325, 4451.77741112943, 4461.375407442961, 4226.746395216297, 4268.231718290706, 4361.280388735855, 4393.978030109861, 4422.933655995163, 4312.9137417251795, 4327.7619730914785, 4330.350447432878, 4333.349997500369, 4334.393184954109, 4313.525512193656, 4318.762468064255, 4321.956780432187, 4323.2434323993175, 4325.978370108161, 4605.562471565196, 4639.420072490939, 4664.277037059262, 4671.392718946549, 4679.040796636681, 4929.408470983505, 4953.257011448276, 5028.296038554606, 5031.421386540558, 5093.1850903855575, 4839.975800121012, 5059.443461219263, 5071.112555302844, 5080.695158290514, 5139.922901156486, 4550.021745324705, 4586.243269860435, 4627.629789616823, 4656.860294191112, 4677.555632214934, 5164.845054648366, 5173.172292433268, 5179.689218646818, 5180.9740951295, 5222.529972302511, 4940.604751619861, 4962.478939711278, 4965.354503914468, 4972.105021096238, 5026.547610715053, 4861.440934292531, 4918.508149185053, 4976.7262800545595, 4983.8006479741125, 5029.547340739351, 5003.624728145331, 5003.774830132653, 5043.0, 5060.1903695408555, 5069.518395752471, 4960.032793605213, 4963.528464795839, 4965.47862474435, 4967.60259179272, 5034.773435195425, 4139.089400331922, 4168.6665066794585, 4169.124483858363, 4266.914661706748, 4267.018585725301, 3689.2252626948643, 3705.981470092632, 3711.03513086594, 3721.0883333583447, 3806.3909774435956, 4369.694121411534, 4374.62815660666, 4377.321515165155, 4418.248897687401, 4425.977870110629, 4862.051899879561, 5010.674306170087, 5030.622703297267, 5033.899322013613, 5038.79844806211, 4286.892827679333, 4313.611774940207, 4341.826326946887, 4344.54382289855, 4390.209762242763, 4513.526079761577, 4517.887052823706, 4522.412086428809, 4535.7732113394195, 4590.05903789729, 4692.48382677912, 4722.150012997762, 4737.715737055788, 4741.810327586858, 4794.832180873653, 4920.827771027997, 4970.950290497049, 4974.651774375759, 5044.066847633199, 5051.4443411225475, 4738.123447162286, 4763.404574428197, 4764.475907650087, 4764.880877978078, 4765.785539650793, 4952.331435256195, 4958.652894297365, 4961.08219979305, 4962.45413004562, 4965.230389289666, 5031.094403007493, 5039.319691841554, 5039.84880453587, 5040.319556859777, 5045.0, 4888.462269150462, 4890.413150421972, 4894.363732714724, 4894.535019173173, 4899.387576552931, 4810.470848206624, 4866.95133048665, 4868.951310486991, 4871.63462740303, 4872.4640289567415, 4797.496262892486, 4798.304245884257, 4833.299171620025, 4842.951570484391, 4853.708777473363, 4970.403551573834, 4971.2046072629655, 4972.5276098770555, 4977.701337919736, 5018.824341148043, 4664.230401983635, 4713.6936099153445, 4739.644526660445, 4841.709497430165, 4908.9754551227015], "value": 4610.120979857281, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.5705792423985, 566.4250785452766, 573.6156774960779, 589.0163427076783, 594.2542109652386, 37853.0, 39697.4045389319, 39938.0, 43356.56643433565, 43457.348139777925, 39169.41245881314, 39565.20869582607, 39585.802070989674, 39615.405768913486, 39651.603483965155, 7633.0458692663415, 7778.5721785301785, 7786.7663970080985, 7786.8442631147345, 7796.610169491531, 7674.5395276283325, 7763.184865589116, 7772.183920688303, 7773.0, 7778.416618753616, 7724.575148366837, 7779.377649788032, 7783.532988020708, 7785.493942893722, 7792.064952205715, 7634.847303053935, 7737.961310193441, 7740.380769538423, 7753.496022758559, 7767.184445633184, 7615.80960475987, 7685.923140768577, 7686.231376862325, 7688.461807673465, 7691.307782299564, 37705.05737356561, 38054.42918356227, 38062.0, 38123.80938095319, 38166.0, 2680.584509401046, 2701.6757989041243, 2963.2147480917574, 3411.6929476347, 3595.856165753367, 26844.46311073787, 28518.714812851813, 28937.855310723313, 28984.855075724696, 29800.701992980008, 3459.768290747513, 3490.3542844573835, 3522.3131489359585, 3565.607783143852, 3647.1611529348397, 255966.0, 256469.0, 256862.0, 256910.0, 256957.0, 31653.0, 50512.49487505152, 50548.74725626349, 50829.745851270505, 50836.0, 31662.841685791424, 33322.83338583291, 33489.330213395595, 33564.49653255203, 33592.1601959953, 12076.75846483083, 12245.387730613435, 12257.938710306391, 12260.75478490443, 12263.141580089487, 9773.120419162167, 9862.753431164278, 9869.457179855177, 9872.901270987342, 9881.357711748857, 7889.526628402315, 7906.920930790733, 7936.682532698743, 8005.759827205193, 8020.2781749641645, 3079.4610943085318, 3121.609798775153, 3131.3111115554543, 3158.210447388153, 3229.3218424131196, 827.4332082523491, 926.8192702423098, 926.893407258174, 954.2032402943481, 962.9951850240844, 26856.731432685814, 27205.72794272032, 27462.725372746416, 28002.43995120086, 28536.0, 908.336914052732, 922.1009515722251, 952.1858810716737, 958.6884262614539, 992.811365840488, 14392.0, 14661.780073298909, 14685.870548770583, 14760.63098422548, 14981.925090374478, 399626.0, 402535.0, 403950.0, 404257.0, 406510.0, 48330.066797328414, 49024.0, 49057.50942490529, 49091.263631045564, 49165.0, 1027.275770581738, 1071.689210129054, 1133.2180795251415, 1142.126273400849, 1145.4101137914147, 27628.0, 29028.419431611674, 29238.0, 29713.554296686, 30152.396952061274, 41468.377974331015, 41730.582694173885, 41822.0, 41828.999999998785, 41932.37101443542, 298288.0, 299333.0, 300076.0, 300102.0, 300538.0, 22532.098716051176, 23176.4205894854, 24135.51728965446, 24441.38896527601, 24588.139415120386, 40747.0, 41001.79499102486, 41069.0, 41146.794266028475, 41205.0, 34734.30531389409, 35100.297994040484, 35166.472502911965, 35302.0, 35939.46090808588, 34978.125546860516, 35329.82335088308, 35471.467927980586, 35667.0, 35681.82159089188, 33711.0, 33892.0, 34234.31531369408, 34426.0, 35042.29915401729, 29818.850905745334, 32106.51840222352, 32199.839000804845, 32345.0, 32707.836460817543, 24600.384990375383, 24732.38169045788, 24990.875045624656, 25246.747532525176, 25511.74488255168], "value": 16190.217351112886, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.5674504085179, 367.7370679963827, 369.31860716977167, 383.3349139243414, 386.1003861003861, 15337.07977521348, 16532.504024879257, 16715.414960476384, 16746.74879876803, 16755.83244167558, 16170.11064391458, 16223.83776162238, 16353.34586616537, 16705.248263828125, 16836.83163168368, 4912.606991440685, 5202.4277329493725, 5203.349581302337, 5206.0, 5208.895822083556, 3634.618365071669, 3832.176082142339, 4992.076465853828, 5800.390958949313, 6063.060225665007, 6086.726097325609, 6166.4450199482035, 6168.475679567242, 6172.321044685081, 6184.103305020769, 5930.288365396137, 6121.908171377433, 6136.509079273647, 6147.999999999977, 6149.354317796612, 5207.270982062514, 5304.549113325372, 5397.8380648580605, 5404.756785944642, 5406.648567843117, 20424.897875510527, 20590.0, 20642.690359644617, 20673.896630516752, 20762.48093797667, 1728.887622304546, 1909.4653497020856, 2311.6879221305244, 2437.878106094688, 2453.77915987562, 12639.241645501208, 12844.550440734529, 12882.0, 13403.128796628189, 13806.65483362914, 1684.4020372767613, 1774.9290028398848, 1818.0, 1830.9176087076114, 1855.4248183063294, 44861.0, 65909.3409065908, 65974.67012664906, 67568.66215668939, 69119.0, 9077.228435583049, 9267.629294828132, 9295.953520232355, 9303.25573954082, 9892.55483503244, 13322.400491977884, 13339.73176571746, 13346.265955372353, 13349.799753003712, 13350.933245333712, 6439.967800161063, 6505.21937367519, 6544.8363790905605, 6575.276719560845, 6768.255491895888, 5788.27646544182, 5830.825075247664, 5995.370486098984, 6001.669908155093, 6011.609245399035, 5959.702014899324, 6003.849903752441, 6013.458788709037, 6038.365971572922, 6076.5442591805795, 1542.2057640315247, 1648.711475491784, 1725.55998220453, 1735.245168351771, 1778.5731424458295, 841.6979560900932, 844.1811442900377, 890.8040231149137, 891.6700820696384, 957.3203025851724, 15874.126923019114, 16660.001599616004, 16742.665146696996, 18200.271989120287, 19363.32228372, 816.5304949653972, 827.1686954610698, 859.5959898847532, 863.2575984653193, 867.3754896474528, 9011.909880901107, 9495.952520237355, 9641.37331073492, 9689.806203875884, 9897.851532227023, 367972.0, 369017.0, 370177.0, 373938.0, 394016.0, 77299.22700773033, 77890.6105469469, 77983.8620979269, 79437.0, 79444.60277698575, 869.8390797702446, 909.3907082254905, 915.3455279475207, 928.0672923711627, 929.2890938432105, 11327.716807079889, 14652.780208297097, 15316.693666126392, 16255.187240638157, 16379.0, 36857.07857303589, 36967.630323696416, 37091.629083708816, 37778.62221377751, 38125.61874381221, 47040.0, 48298.517014829406, 48577.271340929205, 50241.24638130504, 50485.747571261905, 4884.780184891617, 5670.979223739601, 6432.807015789534, 7137.750178743719, 7728.613569321624, 11466.827997579876, 11489.425528723363, 11765.176437649283, 11801.645950621494, 11869.465874035863, 9951.263402564353, 10177.949110254698, 10379.740506487096, 10388.792224155324, 10591.735206619896, 10271.0, 10329.328593641389, 10344.793104137725, 10465.9476702616, 10704.411257380607, 10097.798044038931, 10308.639197628047, 10496.947515262375, 10505.632302869362, 10564.947175264075, 7412.444066695128, 7469.551826890404, 7505.512141710771, 7648.694052238071, 7752.8449431012195, 8856.64573417056, 10081.546330415002, 10263.281570290306, 10605.41670208146, 10616.363018218932], "value": 8241.429129141297, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1290.0324756432672, 1340.7251513439746, 1351.5269655620534, 1606.4698649445684, 1629.3482606957216, 6509.674516274191, 6743.662816859162, 6975.965120174398, 7635.961820190892, 7640.503367281123, 7119.0, 7395.926040739591, 7421.443391745614, 7609.619519024054, 7610.885836712454, 2094.2251366994196, 2115.3971118231307, 2117.2483768262277, 2120.7985241402043, 2120.830333573318, 2067.54514006919, 2080.365488525999, 2098.590774798915, 2100.233414803601, 2117.87292762434, 2064.2878207018553, 2067.328118361531, 2067.390119914629, 2085.593309304686, 2093.874367537945, 1935.6225536020481, 1937.321937321926, 1938.4572319750423, 1945.085809669453, 1946.8150525700037, 1656.4202529114834, 1722.6382459683482, 1821.4444594398703, 1897.1652472912012, 1987.9105440255223, 7230.27697230278, 7515.436342274296, 7528.8117797054965, 7530.171681115073, 7550.320471157567, 4273.7008409411355, 4389.5390983946545, 4423.292273236299, 4430.26900561407, 4430.778461076933, 2685.731426857318, 2773.875175617082, 2821.548552231633, 2830.4197639483855, 2832.702566230537, 811.350919264586, 812.5612169428501, 828.1552816127517, 829.1666874790857, 831.4470876866876, 10034.448105354202, 10067.748306292327, 10074.445905475195, 10121.949390253001, 10133.543990520371, 3721.888343349704, 3897.5322961244833, 4018.4976877890263, 4043.4945631796027, 4045.9190816183514, 8629.13708629132, 8630.180132887366, 8646.870296945552, 8648.43785153963, 8653.783655408539, 4339.218940590661, 4362.6946113772365, 4374.431323927869, 4376.124775045004, 4376.627986621173, 3917.764934103963, 3977.5028121484816, 3979.184267225212, 3994.9201015979515, 3997.240524300432, 3212.9196770080935, 3307.206270495064, 3346.531485592019, 3362.394768941565, 3368.1579605098727, 1034.384541197986, 1035.9896401035894, 1039.308859608352, 1042.4318746283293, 1042.7914417116608, 608.3672980100646, 691.6576294734139, 748.5097261293861, 773.3194788586009, 790.7588185603446, 4875.634327425457, 4930.482299358588, 4991.176455884738, 5019.222020586815, 5055.51972562606, 814.7270664327398, 845.6701886264361, 852.5651917521984, 854.9487030778173, 860.4794099569796, 3412.129906873731, 3439.94840077399, 3476.617572067071, 3524.22467057247, 3594.9281014379567, 8222.506649601042, 8673.6530538779, 8680.8697869532, 8681.131886811268, 8687.087855775178, 8377.790555236046, 8435.789105272417, 8626.525541095174, 8647.827043459096, 8655.956720216358, 6802.387785099266, 6967.756128535477, 6968.477364197604, 6969.895451568231, 6971.128608923885, 4777.355057067251, 4985.92802547454, 4995.8001679932395, 5014.6991180529285, 5049.141645920276, 7923.801904952192, 8135.0, 8316.459430137022, 8325.916740832756, 8344.707935222237, 8245.876311855207, 8343.666253349798, 8543.102974187621, 8555.871661924952, 8559.700410485602, 6565.934340656532, 6711.865762684816, 6722.831929201809, 6726.091977583159, 6736.225334086643, 6795.558288711218, 6857.828554286183, 6939.063226464363, 7025.297470253138, 7108.0, 6219.471344935731, 6259.843503912439, 6305.5270854687, 6320.083587879823, 6582.17722784652, 6037.366076562073, 6054.3340232575265, 6059.878802424015, 6151.96924015377, 6302.558820882494, 5516.972415137899, 5687.60186786921, 5823.5923485355615, 5887.882242355215, 5891.263592050994, 4148.564400738, 4219.873403797891, 4236.11041681238, 4261.105167914772, 4293.892652683708, 4119.485064366954, 4189.518205406417, 4196.475440569929, 4212.883585849813, 4245.1085272093205], "value": 3860.326575145877, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [270.71033993626816, 278.39310303538286, 282.46331969258404, 292.67074541141216, 295.7471361985504, 4831.173763348441, 4847.951520484794, 4851.757412129393, 4854.320395144682, 4855.198892182794, 4756.406603787726, 4785.090832741786, 4789.928151077736, 4793.3528973588645, 4809.470958194595, 3778.301014312361, 3791.2227993261317, 3791.4502397152396, 3795.734298599099, 3811.5426148862175, 3803.6957043436596, 3809.104860357814, 3813.0, 3828.540575130988, 3854.730168888179, 3634.418493041114, 3746.4942232798494, 3764.209516001643, 3766.0961369271454, 3769.321522126016, 3764.4541541476606, 3770.1517158639363, 3774.3583590789767, 3781.0925377909243, 3783.1109689223013, 3094.3037816491333, 3332.8500217490273, 3335.949960750591, 3338.565986421774, 3345.96654033459, 4529.776960220722, 4532.252178390561, 4648.512476007679, 4662.230731929228, 4678.578927896471, 4242.851500197478, 4248.299030659938, 4256.191323648497, 4262.637675797561, 4283.357496375568, 4670.299455081765, 4993.6005119590345, 5011.942714943882, 5016.272640467148, 5018.723970181639, 3280.2455435250026, 3535.8762443314617, 3556.484309775068, 3561.715062794996, 3564.1446052947367, 5199.428062913076, 5202.401723801736, 5205.6876587404495, 5206.114960456732, 5209.843704688866, 3631.2555926035097, 3637.5998640149564, 3641.708663306982, 3644.325799727059, 3655.3785856404475, 3575.3385623659706, 3668.523091998023, 3671.3208056509097, 3673.0, 3711.294853977736, 4200.684948628865, 4203.47456567929, 4204.66362690984, 4206.72656277341, 4214.599613036757, 4971.757060734816, 4975.875603109879, 4978.701277923264, 5004.974975125101, 5017.172166592544, 1237.7400745843295, 1265.5380786013038, 1285.4151361130664, 1290.2065229883553, 1291.5479582146174, 799.9920100673194, 816.3428440105772, 834.7120243515977, 836.7489753074053, 838.6771093129189, 3966.801659916993, 3983.880483585497, 3990.8204130814183, 3997.340438827619, 4043.7775922323967, 4514.7291162530355, 4528.705634133771, 4542.5911667949385, 4542.682012259176, 4560.1335746208115, 3940.8670107264793, 3948.532167395378, 3973.344398174269, 3985.8405663773124, 3996.540397854284, 2410.722766881796, 2414.227447216909, 2576.755208255213, 2785.916422507328, 2793.8184018038764, 4737.976310118427, 4855.44162421319, 4995.275685025651, 5004.249362595567, 5004.474530174352, 5241.816536421207, 5324.361076670824, 5363.410024897258, 5369.5972802040005, 5399.4600539945695, 4995.800167993312, 4998.600111991032, 4999.675086102186, 5000.224965130411, 5005.924911126409, 5024.171011783015, 5186.870328241824, 5216.608754343515, 5237.821490164835, 5262.921056184084, 5080.7229337078115, 5128.410232823124, 5131.307273518028, 5136.922946155885, 5139.511746384088, 4977.8257760978195, 4983.551480366785, 4984.651074424755, 4988.326575912205, 4995.875103122451, 3455.41257986148, 3570.517980072657, 3580.7672501287334, 3611.331903597843, 3637.1089083174793, 5164.941187056719, 5171.922421163761, 5198.4801519847715, 5202.583793296603, 5207.2449494823795, 5057.861981054233, 5060.342155519759, 5061.39263288393, 5061.392632884077, 5082.415522214993, 4792.969511555032, 5025.145725226647, 5061.164907790173, 5062.190049592047, 5091.287219789307, 4996.2755400466, 4997.9500204997485, 5002.52476014778, 5003.874903127451, 5004.1492946198505, 5120.923186152137, 5142.794288228429, 5149.9742501287255, 5176.4305926348825, 5183.844484665316, 4799.832005879777, 4993.1012417763695, 4994.200927851526, 5002.574781143643, 5043.0], "value": 3747.697896568919, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [528.3026405145209, 561.320801829786, 586.5454272938473, 604.5767962426303, 646.3471893387677, 12047.337396443203, 12411.255324680526, 12890.033247506428, 12940.74118517629, 12961.222326660396, 12252.877471225285, 12268.447919843606, 12353.567625133122, 12366.752664946718, 12376.938115309433, 747.5738828867547, 765.1888997662468, 769.4037121231034, 771.1440301265591, 771.4098714483424, 615.5168192968521, 631.7567736421488, 745.8359160984575, 768.2624680306913, 775.0699161006786, 810.4569938141459, 811.8985126859143, 812.4353574265888, 812.6018251056998, 813.0527934955769, 799.7960520067346, 800.4356928365488, 800.8718605023197, 801.0507548554981, 801.4510060608472, 473.9928901066487, 479.3911732100213, 568.5338022821288, 584.1763114009227, 588.8616175198824, 11591.478383472764, 11605.709857253552, 11636.592719254786, 11640.06879449642, 11647.6505704829, 11108.888911110866, 11759.51887923427, 11846.111541634325, 11946.402679865972, 12453.439595218237, 11052.281601695944, 11106.44467776608, 11171.16216283782, 11172.832407513893, 11336.829947550794, 3961.2473630010204, 3981.124152686404, 3984.5218573771044, 4077.184563087365, 4085.3259212229946, 51738.0, 53646.73176634131, 53918.191227131625, 61240.0, 61287.0, 9589.952050239704, 9752.658656946973, 9792.55933482995, 9906.0, 9982.550785214538, 17530.0, 17536.123193840256, 17538.824611753975, 17561.697384140967, 17571.945683259044, 6371.458426033839, 6479.384458476437, 6717.932820671828, 6718.966405167943, 6719.0, 3318.9336213276083, 3345.531625572422, 3377.67912048355, 3489.1102768793794, 3512.438009918452, 2672.078133044097, 2775.0426102994434, 2786.0, 2788.2332358601143, 2793.5530315149476, 457.36883101319967, 462.28576848768733, 467.74975388167167, 471.6886854675897, 474.0211463328216, 438.8924713445226, 457.29119864211003, 505.6561538154017, 521.6557072332242, 560.8289471711167, 6975.3024697529845, 7084.636692311078, 7661.655225514865, 7763.661625501089, 8020.759377218576, 536.841631718644, 541.1044720986773, 551.178743671926, 561.6321309542175, 568.7838621323871, 3669.798161101165, 3727.142757165813, 3752.3058234226755, 3860.2472517858746, 3870.1679138985255, 97029.0, 101327.49336253271, 101958.0, 102811.48594256981, 103035.0, 39735.60264397319, 48887.75556122268, 48955.755221224375, 49185.0, 73656.89514657285, 73822.0, 74569.62715186497, 74989.62505187439, 75225.0, 76604.61697691475, 7472.813179670552, 7805.14143444232, 7853.921460785547, 7878.960605196938, 8133.34933205354, 32637.0, 40209.08964669035, 41914.58085419229, 43719.125617488105, 44110.77944610385, 63667.0, 64647.67676161589, 65079.67460162669, 65537.34462655312, 66362.33637663562, 11159.27464714791, 11357.375344355809, 11369.090472761995, 11703.0, 11712.414379280832, 12725.745485090432, 12766.42551085222, 12795.61613151607, 13023.544175953795, 13588.0, 11195.44022798873, 11231.4384280784, 11295.039921606756, 11307.151963602599, 12169.939150304192, 11256.268342557707, 11351.886481135083, 11946.880531194924, 11976.341301228516, 12353.0, 12106.576269830866, 12114.878851211375, 12128.393580321124, 12131.939340303243, 12136.514539418678, 9463.668771593237, 9630.855537167088, 9737.805243895224, 9871.40771553709, 10202.795944080928, 8858.487892902749, 9209.309301802527, 9393.85909211376, 9732.70801875945, 10243.539040743333], "value": 6244.526786845742, "unit": "score"}], "name": "dromaeo_css", "value": 6177.568731149171, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 117.0, 116.0, 116.0, 116.0, 116.0, 113.0, 114.0, 115.0, 115.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 129.0, 131.0, 171.0, 139.0, 129.0, 137.0, 126.0, 172.0, 132.0], "value": 141.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 163.0, 161.0, 159.0, 160.0, 164.0, 164.0, 161.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 107.0, 77.0, 79.0, 78.0, 78.0, 107.0, 77.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 113.0, 84.0, 85.0, 84.0, 111.0, 84.0, 83.0, 120.0], "value": 93.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0, 118.0, 120.0, 116.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 145.0, 146.0, 146.0, 147.0, 146.0, 145.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 64.0, 63.0, 65.0, 64.0, 65.0, 64.0, 65.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 66.0, 67.0, 65.0, 66.0, 66.0, 66.0, 72.0], "value": 66.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 82.0, 82.0, 84.0, 83.0, 83.0, 83.0, 83.0, 82.0, 83.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 140.0, 140.0, 156.0, 138.0, 155.0, 138.0, 137.0, 176.0, 138.0], "value": 145.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 174.0, 174.0, 176.0, 173.0, 171.0, 176.0, 178.0, 177.0, 172.0], "value": 175.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 71.0, 73.0, 70.0, 79.0, 72.0, 70.0, 70.0, 68.0], "value": 71.2, "unit": "score"}], "name": "kraken", "value": 1561.5000000000002, "alertThreshold": 2.0}]} 21:23:25 INFO - Return code: 0 21:23:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:23:25 INFO - # TBPL SUCCESS # 21:23:25 INFO - Running post-action listener: _resource_record_post_action 21:23:25 INFO - [mozharness: 2016-10-04 04:23:25.543220Z] Finished run-tests step (success) 21:23:25 INFO - Running post-run listener: _resource_record_post_run 21:23:25 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 4096; Write bytes: 391213056; Read time: 16; Write time: 266040 21:23:25 INFO - TinderboxPrint: CPU usage
13.0% 21:23:25 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 21:23:25 INFO - TinderboxPrint: I/O write bytes / time
391,213,056 / 266,040 21:23:25 INFO - TinderboxPrint: CPU idle
8,359.9 (86.9%) 21:23:25 INFO - TinderboxPrint: CPU user
1,204.3 (12.5%) 21:23:25 INFO - TinderboxPrint: Swap in / out
0 / 0 21:23:25 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 100028416; Read time: 0; Write time: 111136 21:23:25 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 291184640; Read time: 0; Write time: 154904 21:23:26 INFO - Running post-run listener: _upload_blobber_files 21:23:26 INFO - Blob upload gear active. 21:23:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:23:26 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 21:23:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:23:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:23:26 INFO - (blobuploader) - INFO - Open directory for files ... 21:23:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:23:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:23:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:23:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:23:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:23:27 INFO - (blobuploader) - INFO - Done attempting. 21:23:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:23:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:23:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:23:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:23:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:23:30 INFO - (blobuploader) - INFO - Done attempting. 21:23:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:23:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:23:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:23:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:23:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:23:31 INFO - (blobuploader) - INFO - Done attempting. 21:23:31 INFO - (blobuploader) - INFO - Iteration through files over. 21:23:31 INFO - Return code: 0 21:23:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:23:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:23:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/360a44d6a9e9c3124c49d48c978b2042faaa1cb54f5788c1f2d5ef751cf9ad2044f826a45ea0a0f3b43757d0cc1617378be9295a9d7b6253aee34381e5f31e01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3c7d5d805fbcdea2f8b5d3a41b6ea14671c9c047b96cb3457994e7a2450ba5f10d1e4573fa1bc5da09088e58b58eec55279e5d9790d6bf886fe0202b71987e4f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0cb8b5eaeb0d0bf89a46a41aab36b24ee201b293a087f3515f35b1f9c082105e412f6eb9fadd2a32f6b8a8610253f04be93ffd91d9796698ad908a684bab72f5"} 21:23:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:23:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:23:31 INFO - Contents: 21:23:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/360a44d6a9e9c3124c49d48c978b2042faaa1cb54f5788c1f2d5ef751cf9ad2044f826a45ea0a0f3b43757d0cc1617378be9295a9d7b6253aee34381e5f31e01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3c7d5d805fbcdea2f8b5d3a41b6ea14671c9c047b96cb3457994e7a2450ba5f10d1e4573fa1bc5da09088e58b58eec55279e5d9790d6bf886fe0202b71987e4f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0cb8b5eaeb0d0bf89a46a41aab36b24ee201b293a087f3515f35b1f9c082105e412f6eb9fadd2a32f6b8a8610253f04be93ffd91d9796698ad908a684bab72f5"} 21:23:31 INFO - Running post-run listener: copy_logs_to_upload_dir 21:23:31 INFO - Copying logs to upload dir... 21:23:31 INFO - mkdir: /builds/slave/test/build/upload/logs 21:23:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.732042 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-10-03 21:23:31.282596) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 21:23:31.286568) ========= 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=4300f881736b422476174874000001bc-1475553034.378506-972252565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/360a44d6a9e9c3124c49d48c978b2042faaa1cb54f5788c1f2d5ef751cf9ad2044f826a45ea0a0f3b43757d0cc1617378be9295a9d7b6253aee34381e5f31e01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3c7d5d805fbcdea2f8b5d3a41b6ea14671c9c047b96cb3457994e7a2450ba5f10d1e4573fa1bc5da09088e58b58eec55279e5d9790d6bf886fe0202b71987e4f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0cb8b5eaeb0d0bf89a46a41aab36b24ee201b293a087f3515f35b1f9c082105e412f6eb9fadd2a32f6b8a8610253f04be93ffd91d9796698ad908a684bab72f5"} build_url:https://queue.taskcluster.net/v1/task/Rm8dUGc_TgijMxFkv85BwA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011250 build_url: 'https://queue.taskcluster.net/v1/task/Rm8dUGc_TgijMxFkv85BwA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/360a44d6a9e9c3124c49d48c978b2042faaa1cb54f5788c1f2d5ef751cf9ad2044f826a45ea0a0f3b43757d0cc1617378be9295a9d7b6253aee34381e5f31e01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3c7d5d805fbcdea2f8b5d3a41b6ea14671c9c047b96cb3457994e7a2450ba5f10d1e4573fa1bc5da09088e58b58eec55279e5d9790d6bf886fe0202b71987e4f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0cb8b5eaeb0d0bf89a46a41aab36b24ee201b293a087f3515f35b1f9c082105e412f6eb9fadd2a32f6b8a8610253f04be93ffd91d9796698ad908a684bab72f5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 21:23:31.314914) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 21:23:31.315605) ========= 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=4300f881736b422476174874000001bc-1475553034.378506-972252565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004425 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 21:23:31.400129) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 21:23:31.400474) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 21:23:31.400799) ========= ========= Total master_lag: 0.19 =========