builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-040 starttime: 1476196239.34 results: success (0) buildid: 20161011043001 builduid: d927cf4c0ed840dd96990d5b01133743 revision: 7ae377917236b7e6111146aa9fb4c073c0efc7f4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-11 07:30:39.343724) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-11 07:30:39.344242) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-11 07:30:39.344532) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-11 07:30:39.359527) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 07:30:39.359936) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1476196239.261761-66575131 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-11 07:30:39-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 111M=0s 2016-10-11 07:30:40 (111 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124302 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 07:30:39.498849) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 07:30:39.499247) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1476196239.261761-66575131 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014755 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 07:30:39.549118) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-11 07:30:39.549485) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7ae377917236b7e6111146aa9fb4c073c0efc7f4 --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 7ae377917236b7e6111146aa9fb4c073c0efc7f4 --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=9e0dfe3369c33a1556e63f89000001d8-1476196239.261761-66575131 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-11 07:30:40,179 truncating revision to first 12 chars 2016-10-11 07:30:40,179 Setting DEBUG logging. 2016-10-11 07:30:40,179 attempt 1/10 2016-10-11 07:30:40,179 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7ae377917236?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-11 07:30:41,492 unpacking tar archive at: mozilla-central-7ae377917236/testing/mozharness/ program finished with exit code 0 elapsedTime=1.714400 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-11 07:30:41.278876) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-11 07:30:41.279425) ========= script_repo_revision: 7ae377917236b7e6111146aa9fb4c073c0efc7f4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-11 07:30:41.280035) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-11 07:30:41.280472) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-11 07:30:41.291693) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-10-11 07:30:41.292316) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9e0dfe3369c33a1556e63f89000001d8-1476196239.261761-66575131 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:30:42 INFO - MultiFileLogger online at 20161011 07:30:42 in /builds/slave/test 07:30:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:30:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:30:42 INFO - {'append_to_log': False, 07:30:42 INFO - 'base_work_dir': '/builds/slave/test', 07:30:42 INFO - 'blob_upload_branch': 'Firefox', 07:30:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:30:42 INFO - 'branch': 'Firefox', 07:30:42 INFO - 'buildbot_json_path': 'buildprops.json', 07:30:42 INFO - 'config_files': ('talos/linux_config.py',), 07:30:42 INFO - 'default_actions': ('clobber', 07:30:42 INFO - 'read-buildbot-config', 07:30:42 INFO - 'download-and-extract', 07:30:42 INFO - 'populate-webroot', 07:30:42 INFO - 'create-virtualenv', 07:30:42 INFO - 'install', 07:30:42 INFO - 'run-tests'), 07:30:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:30:42 INFO - 'download_minidump_stackwalk': True, 07:30:42 INFO - 'download_symbols': 'ondemand', 07:30:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:30:42 INFO - 'tooltool.py': '/tools/tooltool.py', 07:30:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:30:42 INFO - '/tools/misc-python/virtualenv.py')}, 07:30:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:30:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:30:42 INFO - 'installer_path': 'installer.exe', 07:30:42 INFO - 'log_level': 'info', 07:30:42 INFO - 'log_name': 'talos', 07:30:42 INFO - 'log_to_console': True, 07:30:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:30:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:30:42 INFO - 'opt_config_files': (), 07:30:42 INFO - 'pip_index': False, 07:30:42 INFO - 'sps_profile': False, 07:30:42 INFO - 'sps_profile_interval': 0, 07:30:42 INFO - 'suite': 'dromaeojs', 07:30:42 INFO - 'system_bits': '32', 07:30:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:30:42 INFO - 'title': 'talos-linux64-ix-040', 07:30:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:30:42 INFO - 'use_talos_json': True, 07:30:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:30:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:30:42 INFO - 'work_dir': 'build'} 07:30:42 INFO - [mozharness: 2016-10-11 14:30:42.015287Z] Running clobber step. 07:30:42 INFO - Running pre-action listener: _resource_record_pre_action 07:30:42 INFO - Running main action method: clobber 07:30:42 INFO - rmtree: /builds/slave/test/build 07:30:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:30:42 INFO - Running post-action listener: _resource_record_post_action 07:30:42 INFO - [mozharness: 2016-10-11 14:30:42.473295Z] Finished clobber step (success) 07:30:42 INFO - [mozharness: 2016-10-11 14:30:42.473396Z] Running read-buildbot-config step. 07:30:42 INFO - Running pre-action listener: _resource_record_pre_action 07:30:42 INFO - Running main action method: read_buildbot_config 07:30:42 INFO - Using buildbot properties: 07:30:42 INFO - { 07:30:42 INFO - "project": "", 07:30:42 INFO - "product": "firefox", 07:30:42 INFO - "script_repo_revision": "production", 07:30:42 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:30:42 INFO - "repository": "", 07:30:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 07:30:42 INFO - "buildid": "20161011043001", 07:30:42 INFO - "pgo_build": "True", 07:30:42 INFO - "basedir": "/builds/slave/test", 07:30:42 INFO - "buildnumber": 29, 07:30:42 INFO - "slavename": "talos-linux64-ix-040", 07:30:42 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:30:42 INFO - "platform": "ubuntu64_hw", 07:30:42 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:30:42 INFO - "branch": "mozilla-central", 07:30:42 INFO - "repo_path": "mozilla-central", 07:30:42 INFO - "revision": "7ae377917236b7e6111146aa9fb4c073c0efc7f4", 07:30:42 INFO - "stage_platform": "linux64-pgo", 07:30:42 INFO - "builduid": "d927cf4c0ed840dd96990d5b01133743", 07:30:42 INFO - "slavebuilddir": "test" 07:30:42 INFO - } 07:30:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/Z9LOcrN6R7eCPFycCeIPMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 07:30:42 INFO - Running post-action listener: _resource_record_post_action 07:30:42 INFO - [mozharness: 2016-10-11 14:30:42.475812Z] Finished read-buildbot-config step (success) 07:30:42 INFO - [mozharness: 2016-10-11 14:30:42.475900Z] Running download-and-extract step. 07:30:42 INFO - Running pre-action listener: _resource_record_pre_action 07:30:42 INFO - Running main action method: download_and_extract 07:30:42 INFO - mkdir: /builds/slave/test/build/tests 07:30: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')]} 07:30:42 INFO - trying https://queue.taskcluster.net/v1/task/Z9LOcrN6R7eCPFycCeIPMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 07:30:42 INFO - Downloading https://queue.taskcluster.net/v1/task/Z9LOcrN6R7eCPFycCeIPMA/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 07:30:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z9LOcrN6R7eCPFycCeIPMA/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 07:30:43 INFO - Downloaded 1361 bytes. 07:30:43 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 07:30:43 INFO - Using the following test package requirements: 07:30:43 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 07:30:43 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:30:43 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:30:43 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:43 INFO - u'jsshell-linux-x86_64.zip'], 07:30:43 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:30:43 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 07:30:43 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:30:43 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:30:43 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:30:43 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:30:43 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:30:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z9LOcrN6R7eCPFycCeIPMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 07:30:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z9LOcrN6R7eCPFycCeIPMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:30:43 INFO - Fetch https://queue.taskcluster.net/v1/task/Z9LOcrN6R7eCPFycCeIPMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:30:43 INFO - Http code: 200 07:30:43 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 07:30:43 INFO - x-amz-cf-id: HyD0OPSrXeaDFpcg4n6layf01W9mWXKqNP8rIq7ONyeEq4BANHGisw== 07:30:43 INFO - x-amz-version-id: ObezX.35VoD8nBpvEWSk2OCNopDGq.gX 07:30:43 INFO - Expected file size: 22100463 07:30:43 INFO - Obtained file size: 22100463 07:30: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 07:30:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z9LOcrN6R7eCPFycCeIPMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 07:30:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z9LOcrN6R7eCPFycCeIPMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:30:48 INFO - Fetch https://queue.taskcluster.net/v1/task/Z9LOcrN6R7eCPFycCeIPMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:30:48 INFO - Http code: 200 07:30:48 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 07:30:48 INFO - x-amz-cf-id: wyow7hdYW3FbiZM-xQMhyNqy8TD3UPYyjP7j3OU_H57GBYoWOvDHkA== 07:30:48 INFO - x-amz-version-id: ObezX.35VoD8nBpvEWSk2OCNopDGq.gX 07:30:48 INFO - Expected file size: 22100463 07:30:48 INFO - Obtained file size: 22100463 07:30:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z9LOcrN6R7eCPFycCeIPMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 07:30:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z9LOcrN6R7eCPFycCeIPMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:30:53 INFO - Fetch https://queue.taskcluster.net/v1/task/Z9LOcrN6R7eCPFycCeIPMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 07:30:53 INFO - Http code: 200 07:30:53 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 07:30:53 INFO - x-amz-cf-id: LMdvlq7pTVk0EkN3tV8T790tiPU97Zhe94xiQloS8iJuzV3h1REIgQ== 07:30:53 INFO - x-amz-version-id: pSDhGxvc2hpA8RZxXydHfyv61PmGOR1w 07:30:54 INFO - Expected file size: 14409006 07:30:54 INFO - Obtained file size: 14409006 07:30:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:54 INFO - trying https://queue.taskcluster.net/v1/task/Z9LOcrN6R7eCPFycCeIPMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:30:54 INFO - Downloading https://queue.taskcluster.net/v1/task/Z9LOcrN6R7eCPFycCeIPMA/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 07:30:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z9LOcrN6R7eCPFycCeIPMA/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 07:30:55 INFO - Downloaded 59759815 bytes. 07:30:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z9LOcrN6R7eCPFycCeIPMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:30:55 INFO - mkdir: /builds/slave/test/properties 07:30:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:30:55 INFO - Writing to file /builds/slave/test/properties/build_url 07:30:55 INFO - Contents: 07:30:55 INFO - build_url:https://queue.taskcluster.net/v1/task/Z9LOcrN6R7eCPFycCeIPMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:30:56 INFO - Running post-action listener: _resource_record_post_action 07:30:56 INFO - Running post-action listener: set_extra_try_arguments 07:30:56 INFO - [mozharness: 2016-10-11 14:30:56.269565Z] Finished download-and-extract step (success) 07:30:56 INFO - [mozharness: 2016-10-11 14:30:56.269789Z] Running populate-webroot step. 07:30:56 INFO - Running pre-action listener: _resource_record_pre_action 07:30:56 INFO - Running main action method: populate_webroot 07:30:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:30:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:30:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:30:56 INFO - '--tppagecycles', 07:30:56 INFO - '7'], 07:30:56 INFO - 'tests': ['tsvgm']}}, 07:30:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:30:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:30:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:30:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:30:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:30:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:30:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:56 INFO - 'talos_options': ['--disable-e10s'], 07:30:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:30:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:30:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:56 INFO - 'talos_options': ['--disable-e10s'], 07:30:56 INFO - 'tests': ['damp', 'tps']}, 07:30:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:56 INFO - 'tests': ['damp', 'tps']}, 07:30:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:30:56 INFO - 'tests': ['dromaeo_dom']}, 07:30:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:30:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:30:56 INFO - 'tests': ['basic_compositor_video']}, 07:30:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:30:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:30:56 INFO - 'tests': ['a11yr', 07:30:56 INFO - 'ts_paint', 07:30:56 INFO - 'tpaint', 07:30:56 INFO - 'sessionrestore', 07:30:56 INFO - 'sessionrestore_no_auto_restore', 07:30:56 INFO - 'tabpaint']}, 07:30:56 INFO - 'other-e10s': {'tests': ['a11yr', 07:30:56 INFO - 'ts_paint', 07:30:56 INFO - 'tpaint', 07:30:56 INFO - 'sessionrestore', 07:30:56 INFO - 'sessionrestore_no_auto_restore', 07:30:56 INFO - 'tabpaint']}, 07:30:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:30:56 INFO - 'ts_paint', 07:30:56 INFO - 'tpaint', 07:30:56 INFO - 'sessionrestore', 07:30:56 INFO - 'sessionrestore_no_auto_restore', 07:30:56 INFO - 'tabpaint']}, 07:30:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:30:56 INFO - 'ts_paint', 07:30:56 INFO - 'tpaint', 07:30:56 INFO - 'sessionrestore', 07:30:56 INFO - 'sessionrestore_no_auto_restore', 07:30:56 INFO - 'tabpaint']}, 07:30:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:30:56 INFO - 'tests': ['a11yr', 07:30:56 INFO - 'ts_paint', 07:30:56 INFO - 'tpaint', 07:30:56 INFO - 'sessionrestore', 07:30:56 INFO - 'sessionrestore_no_auto_restore', 07:30:56 INFO - 'tabpaint']}, 07:30:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:30:56 INFO - 'tests': ['a11yr', 07:30:56 INFO - 'ts_paint', 07:30:56 INFO - 'tpaint', 07:30:56 INFO - 'sessionrestore', 07:30:56 INFO - 'sessionrestore_no_auto_restore', 07:30:56 INFO - 'tabpaint']}, 07:30:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:30:56 INFO - 'tests': ['tsvgx', 07:30:56 INFO - 'tsvgr_opacity', 07:30:56 INFO - 'tart', 07:30:56 INFO - 'tscrollx', 07:30:56 INFO - 'cart']}, 07:30:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:30:56 INFO - 'tsvgr_opacity', 07:30:56 INFO - 'tart', 07:30:56 INFO - 'tscrollx', 07:30:56 INFO - 'cart']}, 07:30:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:56 INFO - 'talos_options': ['--disable-e10s'], 07:30:56 INFO - 'tests': ['tp5o']}, 07:30:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:56 INFO - 'tests': ['tp5o']}, 07:30:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:56 INFO - 'talos_options': ['--disable-e10s', 07:30:56 INFO - '--xperf_path', 07:30:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:30:56 INFO - 'tests': ['tp5n']}, 07:30:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:56 INFO - 'talos_options': ['--xperf_path', 07:30:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:30:56 INFO - 'tests': ['tp5n']}}, 07:30:56 INFO - 'talos.zip': {'path': '', 07:30:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:30:56 INFO - Running post-action listener: _resource_record_post_action 07:30:56 INFO - [mozharness: 2016-10-11 14:30:56.289330Z] Finished populate-webroot step (success) 07:30:56 INFO - [mozharness: 2016-10-11 14:30:56.289417Z] Running create-virtualenv step. 07:30:56 INFO - Running pre-action listener: _resource_record_pre_action 07:30:56 INFO - Running main action method: create_virtualenv 07:30:56 INFO - Creating virtualenv /builds/slave/test/build/venv 07:30:56 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 07:30:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:30:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:30:56 INFO - Using real prefix '/usr' 07:30:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:30:56 INFO - Installing distribute.............................................................................................................................................................................................done. 07:30:58 INFO - Installing pip.................done. 07:30:58 INFO - Return code: 0 07:30:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:30:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:30:59 INFO - Reading from file tmpfile_stdout 07:30:59 INFO - Output received: 07:30:59 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) 07:30:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:30:59 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')]} 07:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:59 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')]} 07:30:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:59 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 0x7fd03b117f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b797b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c08790>, '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 0x1c09690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c09b20>, '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': '9e0dfe3369c33a1556e63f89000001d8-1476196239.261761-66575131', '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 07:30:59 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 07:30:59 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 07:30:59 INFO - Using env: {'DISPLAY': ':0', 07:30:59 INFO - 'HOME': '/home/cltbld', 07:30:59 INFO - 'LANG': 'en_US.UTF-8', 07:30:59 INFO - 'LANGUAGE': 'en_US:en', 07:30:59 INFO - 'LOGNAME': 'cltbld', 07:30:59 INFO - 'MAIL': '/var/mail/cltbld', 07:30:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:59 INFO - 'MOZ_NO_REMOTE': '1', 07:30:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:59 INFO - 'NO_EM_RESTART': '1', 07:30:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:59 INFO - 'PWD': '/builds/slave/test', 07:30:59 INFO - 'SHELL': '/bin/bash', 07:30:59 INFO - 'SHLVL': '1', 07:30:59 INFO - 'TERM': 'linux', 07:30:59 INFO - 'TMOUT': '86400', 07:30:59 INFO - 'USER': 'cltbld', 07:30:59 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1476196239.261761-66575131', 07:30:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:59 INFO - '_': '/tools/buildbot/bin/python'} 07:30:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:59 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 07:30:59 INFO - Cleaning up... 07:30:59 INFO - Return code: 0 07:30:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:30:59 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')]} 07:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:59 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')]} 07:30:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:59 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 0x7fd03b117f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b797b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c08790>, '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 0x1c09690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c09b20>, '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': '9e0dfe3369c33a1556e63f89000001d8-1476196239.261761-66575131', '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 07:30:59 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 07:30:59 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 07:30:59 INFO - Using env: {'DISPLAY': ':0', 07:30:59 INFO - 'HOME': '/home/cltbld', 07:30:59 INFO - 'LANG': 'en_US.UTF-8', 07:30:59 INFO - 'LANGUAGE': 'en_US:en', 07:30:59 INFO - 'LOGNAME': 'cltbld', 07:30:59 INFO - 'MAIL': '/var/mail/cltbld', 07:30:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:59 INFO - 'MOZ_NO_REMOTE': '1', 07:30:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:59 INFO - 'NO_EM_RESTART': '1', 07:30:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:59 INFO - 'PWD': '/builds/slave/test', 07:30:59 INFO - 'SHELL': '/bin/bash', 07:30:59 INFO - 'SHLVL': '1', 07:30:59 INFO - 'TERM': 'linux', 07:30:59 INFO - 'TMOUT': '86400', 07:30:59 INFO - 'USER': 'cltbld', 07:30:59 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1476196239.261761-66575131', 07:30:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:59 INFO - '_': '/tools/buildbot/bin/python'} 07:30:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:59 INFO - Downloading/unpacking psutil>=3.1.1 07:30:59 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 07:30:59 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 07:30:59 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 07:30:59 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 07:30:59 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 07:30:59 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 07:31:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:31:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:31:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:31:01 INFO - Installing collected packages: psutil 07:31:01 INFO - Running setup.py install for psutil 07:31:01 INFO - building 'psutil._psutil_linux' extension 07:31:01 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 07:31:01 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 07:31:01 INFO - building 'psutil._psutil_posix' extension 07:31:01 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 07:31:01 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 07:31:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:31:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:31:02 INFO - Successfully installed psutil 07:31:02 INFO - Cleaning up... 07:31:02 INFO - Return code: 0 07:31:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:31:02 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')]} 07:31:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:02 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')]} 07:31:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:02 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 0x7fd03b117f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b797b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c08790>, '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 0x1c09690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c09b20>, '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': '9e0dfe3369c33a1556e63f89000001d8-1476196239.261761-66575131', '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 07:31:02 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 07:31:02 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 07:31:02 INFO - Using env: {'DISPLAY': ':0', 07:31:02 INFO - 'HOME': '/home/cltbld', 07:31:02 INFO - 'LANG': 'en_US.UTF-8', 07:31:02 INFO - 'LANGUAGE': 'en_US:en', 07:31:02 INFO - 'LOGNAME': 'cltbld', 07:31:02 INFO - 'MAIL': '/var/mail/cltbld', 07:31:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:02 INFO - 'MOZ_NO_REMOTE': '1', 07:31:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:31:02 INFO - 'NO_EM_RESTART': '1', 07:31:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:31:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:02 INFO - 'PWD': '/builds/slave/test', 07:31:02 INFO - 'SHELL': '/bin/bash', 07:31:02 INFO - 'SHLVL': '1', 07:31:02 INFO - 'TERM': 'linux', 07:31:02 INFO - 'TMOUT': '86400', 07:31:02 INFO - 'USER': 'cltbld', 07:31:02 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1476196239.261761-66575131', 07:31:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:02 INFO - '_': '/tools/buildbot/bin/python'} 07:31:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:31:02 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 07:31:02 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 07:31:02 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 07:31:02 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 07:31:02 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 07:31:02 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 07:31:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:31:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:31:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:31:04 INFO - Installing collected packages: mozsystemmonitor 07:31:04 INFO - Running setup.py install for mozsystemmonitor 07:31:04 INFO - Successfully installed mozsystemmonitor 07:31:04 INFO - Cleaning up... 07:31:04 INFO - Return code: 0 07:31:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:31:04 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')]} 07:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:04 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')]} 07:31:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:04 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 0x7fd03b117f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b797b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c08790>, '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 0x1c09690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c09b20>, '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': '9e0dfe3369c33a1556e63f89000001d8-1476196239.261761-66575131', '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 07:31:04 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 07:31:04 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 07:31:04 INFO - Using env: {'DISPLAY': ':0', 07:31:04 INFO - 'HOME': '/home/cltbld', 07:31:04 INFO - 'LANG': 'en_US.UTF-8', 07:31:04 INFO - 'LANGUAGE': 'en_US:en', 07:31:04 INFO - 'LOGNAME': 'cltbld', 07:31:04 INFO - 'MAIL': '/var/mail/cltbld', 07:31:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:04 INFO - 'MOZ_NO_REMOTE': '1', 07:31:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:31:04 INFO - 'NO_EM_RESTART': '1', 07:31:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:31:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:04 INFO - 'PWD': '/builds/slave/test', 07:31:04 INFO - 'SHELL': '/bin/bash', 07:31:04 INFO - 'SHLVL': '1', 07:31:04 INFO - 'TERM': 'linux', 07:31:04 INFO - 'TMOUT': '86400', 07:31:04 INFO - 'USER': 'cltbld', 07:31:04 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1476196239.261761-66575131', 07:31:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:04 INFO - '_': '/tools/buildbot/bin/python'} 07:31:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:04 INFO - Downloading/unpacking jsonschema==2.5.1 07:31: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 07:31: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 07:31: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 07:31: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 07:31: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 07:31: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 07:31:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:31:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:31: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 07:31: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 07:31: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 07:31: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 07:31: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 07:31: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 07:31:06 INFO - Downloading functools32-3.2.3-2.tar.gz 07:31:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:31:06 INFO - warning: no files found matching '*.txt' 07:31:06 INFO - no previously-included directories found matching 'build' 07:31:06 INFO - no previously-included directories found matching 'dist' 07:31:06 INFO - no previously-included directories found matching '.git*' 07:31:06 INFO - Installing collected packages: jsonschema, functools32 07:31:06 INFO - Running setup.py install for functools32 07:31:07 INFO - warning: no files found matching '*.txt' 07:31:07 INFO - no previously-included directories found matching 'build' 07:31:07 INFO - no previously-included directories found matching 'dist' 07:31:07 INFO - no previously-included directories found matching '.git*' 07:31:07 INFO - Successfully installed jsonschema functools32 07:31:07 INFO - Cleaning up... 07:31:07 INFO - Return code: 0 07:31:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:31:07 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')]} 07:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:07 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')]} 07:31:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:07 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 0x7fd03b117f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b797b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c08790>, '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 0x1c09690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c09b20>, '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': '9e0dfe3369c33a1556e63f89000001d8-1476196239.261761-66575131', '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 07:31:07 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 07:31:07 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 07:31:07 INFO - Using env: {'DISPLAY': ':0', 07:31:07 INFO - 'HOME': '/home/cltbld', 07:31:07 INFO - 'LANG': 'en_US.UTF-8', 07:31:07 INFO - 'LANGUAGE': 'en_US:en', 07:31:07 INFO - 'LOGNAME': 'cltbld', 07:31:07 INFO - 'MAIL': '/var/mail/cltbld', 07:31:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:07 INFO - 'MOZ_NO_REMOTE': '1', 07:31:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:31:07 INFO - 'NO_EM_RESTART': '1', 07:31:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:31:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:07 INFO - 'PWD': '/builds/slave/test', 07:31:07 INFO - 'SHELL': '/bin/bash', 07:31:07 INFO - 'SHLVL': '1', 07:31:07 INFO - 'TERM': 'linux', 07:31:07 INFO - 'TMOUT': '86400', 07:31:07 INFO - 'USER': 'cltbld', 07:31:07 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1476196239.261761-66575131', 07:31:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:07 INFO - '_': '/tools/buildbot/bin/python'} 07:31:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:31:07 INFO - Cleaning up... 07:31:07 INFO - Return code: 0 07:31:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:31:07 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')]} 07:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:07 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')]} 07:31:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:07 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 0x7fd03b117f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b797b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c08790>, '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 0x1c09690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c09b20>, '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': '9e0dfe3369c33a1556e63f89000001d8-1476196239.261761-66575131', '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 07:31:07 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 07:31:07 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 07:31:07 INFO - Using env: {'DISPLAY': ':0', 07:31:07 INFO - 'HOME': '/home/cltbld', 07:31:07 INFO - 'LANG': 'en_US.UTF-8', 07:31:07 INFO - 'LANGUAGE': 'en_US:en', 07:31:07 INFO - 'LOGNAME': 'cltbld', 07:31:07 INFO - 'MAIL': '/var/mail/cltbld', 07:31:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:07 INFO - 'MOZ_NO_REMOTE': '1', 07:31:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:31:07 INFO - 'NO_EM_RESTART': '1', 07:31:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:31:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:07 INFO - 'PWD': '/builds/slave/test', 07:31:07 INFO - 'SHELL': '/bin/bash', 07:31:07 INFO - 'SHLVL': '1', 07:31:07 INFO - 'TERM': 'linux', 07:31:07 INFO - 'TMOUT': '86400', 07:31:07 INFO - 'USER': 'cltbld', 07:31:07 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1476196239.261761-66575131', 07:31:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:07 INFO - '_': '/tools/buildbot/bin/python'} 07:31:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:07 INFO - Downloading/unpacking blobuploader==1.2.4 07:31:07 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 07:31:07 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 07:31:07 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 07:31:07 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 07:31:07 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 07:31:07 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 07:31:09 INFO - Downloading blobuploader-1.2.4.tar.gz 07:31:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:31:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:31: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 07:31: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 07:31: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 07:31: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 07:31: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 07:31: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 07:31:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:31:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:31: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 07:31: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 07:31: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 07:31: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 07:31: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 07:31: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 07:31:10 INFO - Downloading docopt-0.6.1.tar.gz 07:31:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:31:10 INFO - Installing collected packages: blobuploader, requests, docopt 07:31:10 INFO - Running setup.py install for blobuploader 07:31:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:31:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:31:10 INFO - Running setup.py install for requests 07:31:10 INFO - Running setup.py install for docopt 07:31:10 INFO - Successfully installed blobuploader requests docopt 07:31:10 INFO - Cleaning up... 07:31:10 INFO - Return code: 0 07:31:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:31:10 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')]} 07:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:10 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')]} 07:31:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:10 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 0x7fd03b117f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b797b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c08790>, '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 0x1c09690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c09b20>, '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': '9e0dfe3369c33a1556e63f89000001d8-1476196239.261761-66575131', '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 07:31:10 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 07:31:10 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 07:31:10 INFO - Using env: {'DISPLAY': ':0', 07:31:10 INFO - 'HOME': '/home/cltbld', 07:31:10 INFO - 'LANG': 'en_US.UTF-8', 07:31:10 INFO - 'LANGUAGE': 'en_US:en', 07:31:10 INFO - 'LOGNAME': 'cltbld', 07:31:10 INFO - 'MAIL': '/var/mail/cltbld', 07:31:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:10 INFO - 'MOZ_NO_REMOTE': '1', 07:31:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:31:10 INFO - 'NO_EM_RESTART': '1', 07:31:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:31:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:10 INFO - 'PWD': '/builds/slave/test', 07:31:10 INFO - 'SHELL': '/bin/bash', 07:31:10 INFO - 'SHLVL': '1', 07:31:10 INFO - 'TERM': 'linux', 07:31:10 INFO - 'TMOUT': '86400', 07:31:10 INFO - 'USER': 'cltbld', 07:31:10 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1476196239.261761-66575131', 07:31:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:10 INFO - '_': '/tools/buildbot/bin/python'} 07:31:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:31:11 INFO - Running setup.py (path:/tmp/pip-XfeYak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:31:11 INFO - Running setup.py (path:/tmp/pip-LfesYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:31:11 INFO - Running setup.py (path:/tmp/pip-DYHrAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:31:11 INFO - Running setup.py (path:/tmp/pip-zhafjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:31:11 INFO - Running setup.py (path:/tmp/pip-A2O4Cv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:31:11 INFO - Running setup.py (path:/tmp/pip-kTSgVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:31:11 INFO - Running setup.py (path:/tmp/pip-pofrSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:31:11 INFO - Running setup.py (path:/tmp/pip-4lj2ks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:31:11 INFO - Running setup.py (path:/tmp/pip-0ZqY04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:31:11 INFO - Running setup.py (path:/tmp/pip-RhLy73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:31:11 INFO - Running setup.py (path:/tmp/pip-BNR7CZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:31:11 INFO - Running setup.py (path:/tmp/pip-qhB1n2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:31:11 INFO - Running setup.py (path:/tmp/pip-ZUZS0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:31:12 INFO - Running setup.py (path:/tmp/pip-xnl0a2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:31:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:31:12 INFO - Running setup.py (path:/tmp/pip-G0ACJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:31:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:31:12 INFO - Running setup.py (path:/tmp/pip-jSHXK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:31:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:31:12 INFO - Running setup.py (path:/tmp/pip-AM7jTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:31:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:31:12 INFO - Running setup.py install for manifestparser 07:31:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:31:12 INFO - Running setup.py install for mozcrash 07:31:12 INFO - Running setup.py install for mozdebug 07:31:12 INFO - Running setup.py install for mozdevice 07:31:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:31:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:31:12 INFO - Running setup.py install for mozfile 07:31:12 INFO - Running setup.py install for mozhttpd 07:31:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:31:12 INFO - Running setup.py install for mozinfo 07:31:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:31:12 INFO - Running setup.py install for mozInstall 07:31:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:31:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:31:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:31:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:31:13 INFO - Running setup.py install for mozleak 07:31:13 INFO - Running setup.py install for mozlog 07:31:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:31:13 INFO - Running setup.py install for moznetwork 07:31:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:31:13 INFO - Running setup.py install for mozprocess 07:31:13 INFO - Running setup.py install for mozprofile 07:31:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:31:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:31:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:31:13 INFO - Running setup.py install for mozrunner 07:31:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:31:13 INFO - Running setup.py install for mozscreenshot 07:31:13 INFO - Running setup.py install for moztest 07:31:13 INFO - Running setup.py install for mozversion 07:31:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:31:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:31:14 INFO - Cleaning up... 07:31:14 INFO - Return code: 0 07:31:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:31:14 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')]} 07:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:14 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')]} 07:31:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:14 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 0x7fd03b117f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b797b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c08790>, '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 0x1c09690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c09b20>, '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': '9e0dfe3369c33a1556e63f89000001d8-1476196239.261761-66575131', '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 07:31:14 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 07:31:14 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 07:31:14 INFO - Using env: {'DISPLAY': ':0', 07:31:14 INFO - 'HOME': '/home/cltbld', 07:31:14 INFO - 'LANG': 'en_US.UTF-8', 07:31:14 INFO - 'LANGUAGE': 'en_US:en', 07:31:14 INFO - 'LOGNAME': 'cltbld', 07:31:14 INFO - 'MAIL': '/var/mail/cltbld', 07:31:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:14 INFO - 'MOZ_NO_REMOTE': '1', 07:31:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:31:14 INFO - 'NO_EM_RESTART': '1', 07:31:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:31:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:14 INFO - 'PWD': '/builds/slave/test', 07:31:14 INFO - 'SHELL': '/bin/bash', 07:31:14 INFO - 'SHLVL': '1', 07:31:14 INFO - 'TERM': 'linux', 07:31:14 INFO - 'TMOUT': '86400', 07:31:14 INFO - 'USER': 'cltbld', 07:31:14 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1476196239.261761-66575131', 07:31:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:14 INFO - '_': '/tools/buildbot/bin/python'} 07:31:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:31:14 INFO - Running setup.py (path:/tmp/pip-Jbioei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:31:14 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)) 07:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:31:14 INFO - Running setup.py (path:/tmp/pip-3c5t0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:31:14 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)) 07:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:31:14 INFO - Running setup.py (path:/tmp/pip-sar0_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:31:14 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)) 07:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:31:14 INFO - Running setup.py (path:/tmp/pip-PIF5qW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:31:14 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)) 07:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:31:14 INFO - Running setup.py (path:/tmp/pip-jGiKn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:31:14 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)) 07:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:31:14 INFO - Running setup.py (path:/tmp/pip-heE44Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:31:14 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)) 07:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:31:14 INFO - Running setup.py (path:/tmp/pip-wU3tnZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:31:14 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)) 07:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:31:14 INFO - Running setup.py (path:/tmp/pip-Voy9em-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:31:14 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)) 07:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:31:14 INFO - Running setup.py (path:/tmp/pip-cF583x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:31:14 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)) 07:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:31:14 INFO - Running setup.py (path:/tmp/pip-17bRrv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:31:15 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)) 07:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:31:15 INFO - Running setup.py (path:/tmp/pip-SN19j4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:31:15 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)) 07:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:31:15 INFO - Running setup.py (path:/tmp/pip-HZDqq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:31:15 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)) 07:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:31:15 INFO - Running setup.py (path:/tmp/pip-00nZKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:31:15 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)) 07:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:31:15 INFO - Running setup.py (path:/tmp/pip-MghtcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:31:15 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)) 07:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:31:15 INFO - Running setup.py (path:/tmp/pip-tFR6ml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:31:15 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)) 07:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:31:15 INFO - Running setup.py (path:/tmp/pip-QfqCfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:31:15 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)) 07:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:31:15 INFO - Running setup.py (path:/tmp/pip-zzCq9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:31:15 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)) 07:31:15 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)) 07:31:15 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)) 07:31:15 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)) 07:31:15 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)) 07:31:15 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)) 07:31:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:31:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:17 INFO - Downloading blessings-1.6.tar.gz 07:31:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:31:17 INFO - Installing collected packages: blessings 07:31:17 INFO - Running setup.py install for blessings 07:31:17 INFO - Successfully installed blessings 07:31:17 INFO - Cleaning up... 07:31:17 INFO - Return code: 0 07:31:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:31:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:31:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:31:17 INFO - Reading from file tmpfile_stdout 07:31:17 INFO - Current package versions: 07:31:17 INFO - argparse == 1.2.1 07:31:17 INFO - blessings == 1.6 07:31:17 INFO - blobuploader == 1.2.4 07:31:17 INFO - docopt == 0.6.1 07:31:17 INFO - functools32 == 3.2.3-2 07:31:17 INFO - jsonschema == 2.5.1 07:31:17 INFO - manifestparser == 1.1 07:31:17 INFO - mozInstall == 1.12 07:31:17 INFO - mozcrash == 0.17 07:31:17 INFO - mozdebug == 0.1 07:31:17 INFO - mozdevice == 0.48 07:31:17 INFO - mozfile == 1.2 07:31:17 INFO - mozhttpd == 0.7 07:31:17 INFO - mozinfo == 0.9 07:31:17 INFO - mozleak == 0.1 07:31:17 INFO - mozlog == 3.4 07:31:17 INFO - moznetwork == 0.27 07:31:17 INFO - mozprocess == 0.23 07:31:17 INFO - mozprofile == 0.28 07:31:17 INFO - mozrunner == 6.12 07:31:17 INFO - mozscreenshot == 0.1 07:31:17 INFO - mozsystemmonitor == 0.3 07:31:17 INFO - moztest == 0.7 07:31:17 INFO - mozversion == 1.4 07:31:17 INFO - psutil == 3.1.1 07:31:17 INFO - requests == 1.2.3 07:31:17 INFO - wsgiref == 0.1.2 07:31:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:31:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:17 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 0x7fd03b117f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b797b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c08790>, '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 0x1c09690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c09b20>, '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': '9e0dfe3369c33a1556e63f89000001d8-1476196239.261761-66575131', '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 07:31:17 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 07:31:17 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 07:31:17 INFO - Using env: {'DISPLAY': ':0', 07:31:17 INFO - 'HOME': '/home/cltbld', 07:31:17 INFO - 'LANG': 'en_US.UTF-8', 07:31:17 INFO - 'LANGUAGE': 'en_US:en', 07:31:17 INFO - 'LOGNAME': 'cltbld', 07:31:17 INFO - 'MAIL': '/var/mail/cltbld', 07:31:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:17 INFO - 'MOZ_NO_REMOTE': '1', 07:31:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:31:17 INFO - 'NO_EM_RESTART': '1', 07:31:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:31:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:17 INFO - 'PWD': '/builds/slave/test', 07:31:17 INFO - 'SHELL': '/bin/bash', 07:31:17 INFO - 'SHLVL': '1', 07:31:17 INFO - 'TERM': 'linux', 07:31:17 INFO - 'TMOUT': '86400', 07:31:17 INFO - 'USER': 'cltbld', 07:31:17 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1476196239.261761-66575131', 07:31:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:17 INFO - '_': '/tools/buildbot/bin/python'} 07:31:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:18 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)) 07:31:18 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)) 07:31:18 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)) 07:31:18 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)) 07:31:18 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)) 07:31:18 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)) 07:31:18 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)) 07:31:18 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)) 07:31:18 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)) 07:31:18 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)) 07:31:18 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)) 07:31:18 INFO - Cleaning up... 07:31:18 INFO - Return code: 0 07:31:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:31:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd03b117f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b797b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c08790>, '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 0x1c09690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c09b20>, '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': '9e0dfe3369c33a1556e63f89000001d8-1476196239.261761-66575131', '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 07:31:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:31:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:31:18 INFO - Using env: {'DISPLAY': ':0', 07:31:18 INFO - 'HOME': '/home/cltbld', 07:31:18 INFO - 'LANG': 'en_US.UTF-8', 07:31:18 INFO - 'LANGUAGE': 'en_US:en', 07:31:18 INFO - 'LOGNAME': 'cltbld', 07:31:18 INFO - 'MAIL': '/var/mail/cltbld', 07:31:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:18 INFO - 'MOZ_NO_REMOTE': '1', 07:31:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:31:18 INFO - 'NO_EM_RESTART': '1', 07:31:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:31:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:18 INFO - 'PWD': '/builds/slave/test', 07:31:18 INFO - 'SHELL': '/bin/bash', 07:31:18 INFO - 'SHLVL': '1', 07:31:18 INFO - 'TERM': 'linux', 07:31:18 INFO - 'TMOUT': '86400', 07:31:18 INFO - 'USER': 'cltbld', 07:31:18 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1476196239.261761-66575131', 07:31:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:18 INFO - '_': '/tools/buildbot/bin/python'} 07:31:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:31:18 INFO - Cleaning up... 07:31:18 INFO - Return code: 0 07:31:18 INFO - Running post-action listener: _resource_record_post_action 07:31:18 INFO - Running post-action listener: _start_resource_monitoring 07:31:18 INFO - Starting resource monitoring. 07:31:18 INFO - [mozharness: 2016-10-11 14:31:18.388796Z] Finished create-virtualenv step (success) 07:31:18 INFO - [mozharness: 2016-10-11 14:31:18.389310Z] Running install step. 07:31:18 INFO - Running pre-action listener: _resource_record_pre_action 07:31:18 INFO - Running main action method: install 07:31:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:31:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:31:18 INFO - Reading from file tmpfile_stdout 07:31:18 INFO - Detecting whether we're running mozinstall >=1.0... 07:31:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:31:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:31:18 INFO - Reading from file tmpfile_stdout 07:31:18 INFO - Output received: 07:31:18 INFO - Usage: mozinstall [options] installer 07:31:18 INFO - Options: 07:31:18 INFO - -h, --help show this help message and exit 07:31:18 INFO - -d DEST, --destination=DEST 07:31:18 INFO - Directory to install application into. [default: 07:31:18 INFO - "/builds/slave/test"] 07:31:18 INFO - --app=APP Application being installed. [default: firefox] 07:31:18 INFO - mkdir: /builds/slave/test/build/application 07:31:18 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'] 07:31:18 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 07:31:35 INFO - Reading from file tmpfile_stdout 07:31:35 INFO - Output received: 07:31:35 INFO - /builds/slave/test/build/application/firefox/firefox 07:31:35 INFO - Running post-action listener: _resource_record_post_action 07:31:35 INFO - [mozharness: 2016-10-11 14:31:35.707198Z] Finished install step (success) 07:31:35 INFO - [mozharness: 2016-10-11 14:31:35.707438Z] Running run-tests step. 07:31:35 INFO - Running pre-action listener: _resource_record_pre_action 07:31:35 INFO - Running main action method: run_tests 07:31:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:31:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:31:35 INFO - Python 2.7.3 07:31:35 INFO - Return code: 0 07:31:35 INFO - grabbing minidump binary from tooltool 07:31:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:35 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 0x1c08790>, '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 0x1c09690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c09b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:31:35 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 07:31:35 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 07:31:35 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 07:31:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:31:35 INFO - Return code: 0 07:31:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:31:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:31:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:31:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:31:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:31:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z9LOcrN6R7eCPFycCeIPMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 07:31:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Z9LOcrN6R7eCPFycCeIPMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --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 07:31:35 INFO - Using env: {'DISPLAY': ':0', 07:31:35 INFO - 'HOME': '/home/cltbld', 07:31:35 INFO - 'LANG': 'en_US.UTF-8', 07:31:35 INFO - 'LANGUAGE': 'en_US:en', 07:31:35 INFO - 'LOGNAME': 'cltbld', 07:31:35 INFO - 'MAIL': '/var/mail/cltbld', 07:31:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:31:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:31:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:35 INFO - 'MOZ_NO_REMOTE': '1', 07:31:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:31:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:31:35 INFO - 'NO_EM_RESTART': '1', 07:31:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:31:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:35 INFO - 'PWD': '/builds/slave/test', 07:31:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:31:35 INFO - 'SHELL': '/bin/bash', 07:31:35 INFO - 'SHLVL': '1', 07:31:35 INFO - 'TERM': 'linux', 07:31:35 INFO - 'TMOUT': '86400', 07:31:35 INFO - 'USER': 'cltbld', 07:31:35 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1476196239.261761-66575131', 07:31:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:35 INFO - '_': '/tools/buildbot/bin/python'} 07:31:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z9LOcrN6R7eCPFycCeIPMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 07:31:35 INFO - mozversion application_buildid: 20161011043001 07:31:35 INFO - mozversion application_changeset: 7ae377917236b7e6111146aa9fb4c073c0efc7f4 07:31:35 INFO - mozversion application_display_name: Nightly 07:31:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:31:35 INFO - mozversion application_name: Firefox 07:31:35 INFO - mozversion application_remotingname: firefox 07:31:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:31:35 INFO - mozversion application_vendor: Mozilla 07:31:35 INFO - mozversion application_version: 52.0a1 07:31:35 INFO - mozversion platform_buildid: 20161011043001 07:31:35 INFO - mozversion platform_changeset: 7ae377917236b7e6111146aa9fb4c073c0efc7f4 07:31:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:31:35 INFO - mozversion platform_version: 52.0a1 07:31:35 INFO - using testdate: 1476196295 07:31:35 INFO - actual date: 1476196295 07:31:35 INFO - starting webserver on 'localhost:54681' 07:31:35 INFO - SUITE-START | Running 2 tests 07:31:35 INFO - TEST-START | dromaeo_css 07:31:35 INFO - operating with platform_type : linux_ 07:31:35 INFO - Initialising browser for dromaeo_css test... 07:31:35 INFO - TEST-INFO | started process 14067 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppBgLv2/profile http://localhost:54681/getInfo.html) 07:31:40 INFO - PROCESS | 14067 | __metrics Screen width/height:1600/1200 07:31:40 INFO - PROCESS | 14067 | colorDepth:24 07:31:40 INFO - PROCESS | 14067 | Browser inner width/height: 1024/697 07:31:40 INFO - PROCESS | 14067 | __metrics 07:31:40 INFO - PROCESS | 14067 | 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" 07:31:40 INFO - PROCESS | 14067 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:31:41 INFO - PROCESS | 14067 | console.error: PushService: 07:31:41 INFO - PROCESS | 14067 | stateChangeProcessEnqueue: Error transitioning state 07:31:41 INFO - PROCESS | 14067 | UnknownError 07:31:42 INFO - TEST-INFO | 14067: exit 0 07:31:42 INFO - Browser initialized. 07:31:42 INFO - Running cycle 1/1 for dromaeo_css test... 07:31:42 INFO - TEST-INFO | started process 14152 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppBgLv2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:31:54 INFO - PROCESS | 14152 | RSS: Main: 172744704 07:31:54 INFO - PROCESS | 14152 | 07:32:45 INFO - PROCESS | 14152 | 1476196365838 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] 07:34:56 INFO - PROCESS | 14152 | Cycle 1(1): loaded http://localhost:54681/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54681/tests/dromaeo/cssquery-ext.html) 07:34:58 INFO - PROCESS | 14152 | RSS: Main: 324726784 07:34:58 INFO - PROCESS | 14152 | 07:38:00 INFO - PROCESS | 14152 | Cycle 1(1): loaded http://localhost:54681/tests/dromaeo/cssquery-ext.html (next: http://localhost:54681/tests/dromaeo/cssquery-jquery.html) 07:38:01 INFO - PROCESS | 14152 | RSS: Main: 275689472 07:38:01 INFO - PROCESS | 14152 | 07:41:03 INFO - PROCESS | 14152 | Cycle 1(1): loaded http://localhost:54681/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54681/tests/dromaeo/cssquery-mootools.html) 07:41:04 INFO - PROCESS | 14152 | RSS: Main: 246730752 07:41:04 INFO - PROCESS | 14152 | 07:44:06 INFO - PROCESS | 14152 | Cycle 1(1): loaded http://localhost:54681/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54681/tests/dromaeo/cssquery-prototype.html) 07:44:06 INFO - PROCESS | 14152 | RSS: Main: 215252992 07:44:06 INFO - PROCESS | 14152 | 07:47:09 INFO - PROCESS | 14152 | Cycle 1(1): loaded http://localhost:54681/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54681/tests/dromaeo/cssquery-yui.html) 07:47:10 INFO - PROCESS | 14152 | RSS: Main: 214859776 07:47:10 INFO - PROCESS | 14152 | 07:50:13 INFO - PROCESS | 14152 | Cycle 1(1): loaded http://localhost:54681/tests/dromaeo/cssquery-yui.html (next: http://localhost:54681/tests/dromaeo/cssquery-dojo.html) 07:50:13 INFO - PROCESS | 14152 | RSS: Main: 314552320 07:50:13 INFO - PROCESS | 14152 | 07:50:13 INFO - PROCESS | 14152 | __start_tp_report 07:50:13 INFO - PROCESS | 14152 | _x_x_mozilla_page_load 07:50:13 INFO - PROCESS | 14152 | _x_x_mozilla_page_load_details 07:50:13 INFO - PROCESS | 14152 | |i|pagename|runs| 07:50:13 INFO - PROCESS | 14152 | |0;dojo.html;3022.2444388902773;3056.984715076425;3058.3577448735764;3089.536569514574;3107.7669174811895;5056.014077254937;5128.948710512894;5254.054270231357;5325;5350.063738845701;5180.559652429539;5284.656497327681;5373.382061062979;5402.405735369116;5499.807506737255;4723.07899959508;4854.56308932196;4863.805447782084;4889.437714662815;4900.58345040672;4369.866072489047;4868.610511159117;4890.388701412324;4917.4099108107075;4941.160002799515;4938.777755001033;4999.200127979524;5014.974925125388;5045.823396181135;5064.822731204408;4701.106789709944;4729.810807567693;4750.358701575277;4822.011487645024;4896.314515967767;4786.497417771118;4790.880227994293;4790.928136077961;4800.207965685658;4800.279958006292;5206.479352064801;5246.213068039825;5254.290670759437;5297.443768404339;5341.4925582069645;5660.179274005246;5661.8584535386535;5662.943370566324;5748.626339287975;5752;5714.142878568248;5778.566607504454;5781.53747700183;5785.768569257225;5802.477777000048;5099.71951542665;5137.537621614073;5229.6600720953775;5266.052110620049;5373.113436283009;5794.82615521535;5812.128180772918;5819.039858423397;5871.6183448075735;5884.08796636522;5622.353429355595;5624.240727501817;5625.296837895263;5627.127795191752;5632.239647647515;5492.1212605982855;5526.640768350045;5538.0585300499015;5664.178694089334;5680.943190568041;5549.417311182348;5595.300587426572;5603.299587551556;5603.35561410443;5605.215269862222;5600.411956744483;5610.97194514033;5611.102223644198;5612.663240205601;5615.550755939515;4307.095509942885;4335.609795118455;4343.891402714958;4344;4344.6089851913475;3863.9034024149623;3898.6686131679126;3919.2161567686576;3924.9803750981064;3925.941110883282;5405.972970135124;5406.8918621627345;5410.242566040757;5454.481824226692;5476.726163691879;5704.600677952503;5712.457316554921;5712.742926568231;5722.341930678025;5722.37053924068;5285.2600635911;5351.224072509543;5351.25082488452;5394.32570928634;5469.890602187934;4873.902521949542;4924.556789888928;4926.261060840902;4963.851084467472;5027.547520723152;5912.46787789101;5931.377205393458;5932.940670593325;5935.0503919372695;5935.2877654681715;5525;5715.199872017838;5715.999700052557;5718.542516598579;5724.484796368347;5752.33848107473;5865.706714664335;5910.674912879833;5934.762609495572;6042.425969532887;5648.661080335193;5655.971720141373;5656.43435656431;5663.773449062156;5667.943320566742;5785.56608254391;5793.797217097382;5798.072308430799;5801.709914504342;5802.1296805479515;5404.32445944257;5418.885621174731;5426.403095659553;5476.67139971603;5489.039418101896;5454.181872719124;5494.670319780826;5505.944940550543;5507.807226747044;5557.138643510262;5451.7274136292235;5498.340199176125;5499.587530935116;5508.338999320107;5582.972085139549;5447.782088716407;5493.423190564933;5516.806911758069;5543.944560554504;5558.333000040021;5463.72681365938;5465;5467.617266791286;5468.835934921959;5528.585356098389 07:50:13 INFO - PROCESS | 14152 | |1;ext.html;530.6837793604147;579.1631093070512;592.792522617084;595.4343373794893;598.064029793373;33994.320113597714;41559.79220103899;41960;42048.57951420489;44551.331730023994;43291;43660.12679746403;43664.16182948106;43724.78137609307;43764.562354376445;8027.317677997377;8743.562821858914;8887.644494220256;8889.822203555925;8896.466212027266;7848.372130229568;8140.4708693935;8146.2261085196815;10317.58729650813;10532.736681582945;10731.83902241467;10788.946055269713;10790.676279711583;10793.892061079367;10797.460126993657;10549.156067514581;10613.469326533643;10616.893831061669;10625.5218515167;10627.096696780784;7922.128565857751;8138.348932085419;10057.748556286078;10351.792964140675;10380.844287335696;40017.39973900394;40273.395899061536;40282;40339.394909076385;40355;3332.950005749916;3448.189675426273;3673.522442082539;3803.6386543278345;3894.805259737002;29986.25034374136;30283.394332113454;30290.697093029008;31186.68813311883;31422;4043.3732771420478;4066.410370496291;4071.531773845986;4105.753654780723;4124.9381259280835;236801;237315;237634;237811;238191.7084974907;47002.76498617485;48090.5190948093;51529.22706159411;53207.73396132995;54036.459635403146;54277.1858422124;54411.727941360834;54606;54614.72692636511;54686.72656636692;16305.918470407572;16462.670746585;16477.58806029859;16480.4231851887;16493.752593711102;11631.59289424866;12132.150749447454;12143.939280303543;12164.452599632861;12170.878291216974;10855.185861060452;14990.850091498945;15426.614334641723;15440.45958391451;16020.19899005045;5773.566982476331;5777.340175836356;5879.559033072536;5928.407159284124;5963.373845746134;881.38743573216;945.7541039329824;1009.0867764672983;1077.2943721862193;1078.8166011778017;30228.24429389283;30794.846025769726;30918.53622195669;31283.374332513224;31487.84256078705;1057.2440704896037;1093.8577984862077;1148.534843388429;1148.9195756296979;1155.422288855572;15477.458288959833;16318.918405408134;16374.754378684329;16714.4149954751;16715.749263761052;488426;489014;489577;489893;492809;55479.72260138673;55540;55689.44310556923;55715.72142139344;55721.721391392784;1185.7707509881368;1225.5955534673537;1275.655572995286;1320.5774152271374;1337.1709540085403;28727.569086463303;30618.387632246784;30792.53811192879;30800.383992320476;31238.687613123577;44325.77837110794;44765.552344476135;44765.628124625255;44805.55194448014;44825;319727;321119;321531;321952;321962;26581.867090664422;27542.17373478799;27657.44685106327;28516.42967140604;28608.856955715088;44853.10293794171;45175;45490.31764523601;46007.76996114998;46628;38260.42609360806;38467.42298865463;38487.807560963134;39042.41436378514;39540;38505;38741;39531;39957.60042399539;40097.59902401055;39092.60907391003;39573.20853582855;40076.599234007284;40181.39727904142;40555.79722101371;32106.35787284288;34788.130296742784;34924.30151397009;35018.649813501535;35583.82208088943;26669.19992400231;26723.866380667972;27055;27073.864630676722;27224.319392015357 07:50:13 INFO - PROCESS | 14152 | |2;jquery.html;377.87718991327824;395.3891238037234;405.42024904386733;405.4566880380291;424.1749796645524;13592.388342524599;15662.138582377964;19066.809331906694;19286.903565482153;19865.20539178431;14646;14831.258437078157;14877.702445951074;14886.766984952235;16752.49742507727;5491.203775452567;5786.537077033827;5788.623739456922;5793.536517078624;5794.884102317951;5531.2532808071;5607.8878422431735;5659.830205093854;5663.0655941769555;5698.772049118051;5631.60578759487;5637.689927054011;5639.2668953036255;5640.407757185498;5644.294463192101;5361.490658387466;5583.609147359707;5615.438456154393;5617.831465056055;5627.493525582717;5061.190209566488;5066.923996140061;5069.06222348863;5069.290299358093;5073.543381095719;22162.33512994613;22900.19849305283;23047.081996060544;23242;23269.88365058164;2010.6581881080251;2167.295628920607;2284.725832900046;2343.4024323797494;2539.3016920347054;10159.33964292326;10258.538365773558;10323.122534584494;10670.466476676134;10811;1794.246416505058;1815.546113471632;1831.9084045797656;1937.8352840008615;1948.3959972408456;88151.55924220402;88991.55504222566;89813;90770.54614726885;91583.54208228983;10742.83885741699;10820.729481763019;10827.78344433107;11100.833487497694;11323.886761132284;14721.33753981052;15273.770893436607;15304.693906121815;15777.211139442981;15787.447439339798;7973.960130199428;8221.095679475253;8230.753077407688;8402.705905293285;8451.197136272045;7824.687012519549;7867.370610351159;7870.645820938072;8011.719589814328;8161.469504482189;4655.511171326962;4715.3024911032;4788.976055119702;4889.755512224375;4936.6297527685565;1816.9909150454164;1823.2615790604825;1827.1229809691156;1857.76139751599;1858.27527264367;786.4691333349966;932.3520153493392;946.8011717539393;985.3152059318847;1073.8228192348174;18859;19221.90389048074;19256.518587035436;19489.80510194908;19820.20719171217;965.0879918476971;976.3751199232497;985.2905907746411;1005.8893521712606;1081.9134469242442;10020.398776073458;10399.32404393712;10549.367037977747;10621.893781062245;10627.36235825853;467789;470845;486823;487114;487825;89633;91267;92469;103301;106237.46881265698;959.7360725800461;994.2409812769478;1033.338663255517;1043.3479075577764;1047.4972013433594;17210.39763608268;17397.739033914248;17990.460286191435;18019.819801801816;18154.455366339032;42736.78631606822;43997.34003989879;44083.55916440795;44406.779661016175;44921.775391122836;59429.40570594239;59642;59726.402735972086;60192;61163.69418152881;8180.590970451334;8334.291585215324;8434.873476897974;8656.22094011542;8695.521746304014;12508.937455312665;13138.146020508637;13242.735145297233;13305.871060630252;13311;11427.257228280136;11475.368854713071;11773.411329433666;11775.411229438665;12065.155439119177;11305.773884522428;11309.604163854226;11353.716157095809;11407.429628518707;11419;11606.419679015846;11657.708557286136;11912.40437978115;12012.399380031138;12110.697232569257;8961.193492585699;11521.769564608494;11703.23928944616;11958.701032474257;12016.459259333176;11094.5562177512;12156.878431215575;12300.138990270596;12309.32298723543;12505.249685018927 07:50:13 INFO - PROCESS | 14152 | |3;mootools.html;1414.0688884899978;1450.9637259068522;1568.6705791783725;1690.8900921440097;1774.6628140653274;8594.183552562505;9234.03042680519;9234.261259099281;9275.907240927589;9281;7886.29023387895;8112.5943702814775;8557.101504342048;8733.126687331263;8740.606672699729;2340.356401989454;2366.8993917828207;2374.3351861478814;2376.0377047295788;2377.405648587853;2323.744388117306;2341.508283260517;2362.4093976505874;2366.100881664965;2366.645003249509;1889.1782074797438;1928.8746231494908;1930.1025023364202;1944.4944314478196;2283.4177284792354;2329.755375685554;2379.1910750344964;2380.8928598213124;2382.285314405671;2383.2492764779126;2278.8632682038965;2307.723073231223;2309.041747674713;2319.7680231976838;2328.918487852934;9104.089591040909;9159.267258619295;9163.98392353681;9168.220701240403;9173.40372875761;5029.522195391469;5156.871078223037;5206.583473322125;5213.296205012312;5214.296070030536;3344.347852168828;3417.7778444401283;3494.899106781356;3504.299140171976;3517.9472307915403;1159.2059439284117;1195.6532605544382;1219.5731493977125;1231.870653581379;1235.3390935849277;12884.355782210945;12887.613371598867;12899.806502902464;12906.677333066655;12908.87091129086;4621.584057434779;4825.179719447702;4833.178359678863;4835.8065677373215;4844.103840789465;10779.514921828537;10793.83809242862;10830.241883068109;10830.350178989285;10851.45742712877;5276.129438642658;5292.285541451932;5306.09796334624;5332.760025798849;5343.919841202385;4806.038792241566;4808.08646357198;4824.131656301899;4865.416150062015;4951.183054795991;3948.4274780156716;3958.7030972677167;4020.9597904020584;4094.5495995441074;4104.445899803548;1305.4451857960328;1314.2968511846116;1321.0818481155504;1340.9463621455031;1342.0404410846293;893.5442924108621;906.2613969614742;926.8748718922994;927;931.3666706639415;6033.185519954838;6036.8188954331445;6162.506999440034;6451;6499.642519661369;888.9199972002551;895.5298468304193;907.6777743900952;909.5497728624373;915.2769312243254;4046.1705350403095;4122.175564887035;4167.270727622654;4237.110206856533;4258.5954334338185;10787.892121078688;11225.550977960953;11240.887591124148;11243.156763242789;11251.987321141136;10577.735556611146;11163.888361116447;11175.385353805455;11176.217664763388;11189.384583847966;7930.6431210595665;8350.958245208734;8353.540555269397;8354.331653467829;8354.958225208957;5999;6024.578279520391;6025.849353766191;6176.135341052346;6464.2889282177985;9687.854682179914;10094.495275236062;10143.34068285559;10220.386776793417;10245.692629221136;10231;10354.689359319233;10384.896151038392;10482.951704829457;10497.317674351143;7779.688812447665;7923;7990.560519171501;8008.639611217625;8091.797705057421;8538.402311838112;8685.305175586065;8690.391672583111;8694.130586941255;8713.346499012472;7424.587009221917;7546;7558.697652093854;7559.886601701089;7687.961560192387;7195.928040719526;7217.422606191597;7372.225916278713;7400.444966627417;7494.138174110047;7321.048263725682;7333.01004364404;7411.518251313647;7411.62941852916;7417.851642967003;5108.974455127701;5159.380874295109;5159.974200128975;5206.219067139959;5251.71115588631;5145.331106956071;5175.301334319819;5251.474852514871;5277.788888444419;5324.840254792362 07:50:13 INFO - PROCESS | 14152 | |4;prototype.html;324.701274827159;333.8781344809144;336.35755706600366;336.9258763072124;340.18525631113476;5282.23407605897;5295.146698655469;5318.89362212756;5320.281761962134;5381.650192737469;5261.421243663194;5283.392409872866;5309.41596424393;5314;5323.787048518055;3983.8645985893954;4040.2929487339743;4086.346184610463;4108.917821643566;4147.440095587102;4110.321796903508;4115.115250221202;4116.259073366793;4127.277726397883;4131.2442212059905;4055.8909367129077;4094.488188976378;4104.117614712836;4106.850081977052;4141.896452588694;3939.9212015759667;3958.663513601333;4027.6979226558124;4118.402831589403;4129.380592911058;3668.284684486526;3668.5047518584915;3685.7652686350107;3687.1335236219734;3705.3330400527893;5041.319421878073;5089.592832573385;5100.5409513143995;5107.923381149286;5150.484951504857;4486.631577368901;4723.976380118077;4726.125666751662;4741.881452963669;4752.809887604491;5520.641158324696;5529.751161197756;5531.585131115183;5540.9168862467095;5551.9722401388135;3996.480457540501;4006.979965100156;4012.1775036117524;4013.3177359848896;4031.294523458383;5557.749901254413;5682.687452190128;5717.142428635696;5717.9714101429645;5765.221695071195;4045.110075783323;4047.5547689754103;4049.493813273341;4054.2094291612852;4069.2908978229216;4108.650764685035;4109.691773117028;4112.691548133902;4115.650169735606;4126.8761937141935;4591.862244132682;4678.204705200124;4701.811927522861;4716.905661886812;4723;5491.643043202179;5530.86172845674;5535.833924982257;5567.749451274703;5571.526420254243;1407.7043820797542;1425.9091794777005;1426.8715815576647;1428.821222491428;1431.8281806183325;844.7676888855614;889.2397000564554;890.1543533643065;900.7162743735702;902.2917010147003;5101.795928162906;5223.268742376071;5254.185601231815;5373.328333958255;5382.596305277041;5676.545876329884;5676.927921308693;5687.744051517691;5688.345840228344;5702.54379649627;5188.325517682677;5357.973210134002;5372.7313634318125;5395.568354531628;5396.163594642837;2990.624312816129;3006.556852710711;3012.894548690785;3018.2001769531093;3019.230096325423;5881.853038657421;5885.499732522698;5900.468957793819;5910.340346843852;5940.8811823764145;5632.943670563324;5794.507466865363;5796.536277097822;5802.970985145132;5804.767809287581;5871.178035075179;5879.52963762898;5897.52819774417;5908.734106965197;5911.940880591225;5382.757775900172;5580.437477506305;5653.915191272216;5662.886742265214;5676.716164191691;5573.888522229614;5584.329880414376;5593.580481463988;5610.661656314486;5628.85927851807;5881.441263080001;5882.382349853204;5888.676122813286;5905.405540504125;5909.2908850938165;3855.4024126260474;3993.5806740293015;4067.1052368478886;4068.715189936676;4075.49056367954;5604.299462567179;5613.24221230145;5622.269105016485;5632.690202038927;5648.519875810603;5404.621676482609;5504.174373843955;5528.226048353315;5547.33431988164;5555.388907220122;5312.707801070978;5531.446855314436;5565.693886836263;5584.692841893735;5588.748506317307;5547.55619550443;5553.556794787258;5556.611037227517;5557.638753481173;5588.189712491585;5309.36287645485;5453.890922181614;5488.1767734838495;5573.247611572386;5586.916196257141;5455.7817687293655;5456.727163641882;5458.426865179099;5459.344878614592;5462.672239665632 07:50:13 INFO - PROCESS | 14152 | |5;yui.html;735.8601865645527;768.7616838779978;792.6908505682785;815.9020917489902;828.5650033732294;15239.999999999985;15813;16002.279897404616;16050.919745401257;16906.830931690678;15268.618284542865;15439.84560154398;15461.845381546182;15541.378344866192;15597.220138993034;650.6421468192499;675.2538445018258;787.7242964962261;811.3833486550235;816.9019717633893;794.2176955698632;816.2368185746346;824.9381296402764;825.9008918929707;826.6197549127409;876.9649214031431;879.7624641346832;880.295763389286;880.6213328268842;881.1364862434817;680.6630717794674;706.9257727938596;876.3208513402133;876.5617191404298;877.0221203358242;611.843979785152;627.9780207692754;633.5311869216746;634.0995785983914;634.2515831319041;14969.550913472613;14988.325525351276;14989.850101498954;15012.924935375362;15027.699446011018;13918.721625567534;14043.578692639237;14394.712105757932;14489.637759056108;14760.926195368955;12589;12714.554990575378;12800.935995320056;12912.418941147576;12926.54757083507;4225.492940847087;4242.40606315113;4286.525076918491;4310.3103503439615;4335.826566937319;81303.18696813015;81491.5925420375;81617.59191204006;82115;83866.58066709628;10829.430970614972;11061.612843550438;11438.828417573743;11491.942540287246;11746.941265293619;20691.896540517202;20741.58516829655;20799.1680332785;20949.162033518794;21018.89490552568;7198.208197098315;7702;7961.243681850215;8591.742247732578;8617.439866408664;4487.753173575419;4673.737549367816;4703.0593881223895;4834.371531700856;4873.415190177201;3749.8500059997295;3845.5577608574813;3909.4722212500947;3910.550286717007;3911.1395492991496;684.4319215051495;684.9863002740017;692.9896051559231;706.6219572528776;710.4281053751677;716.2372073741449;732.9890051649229;744.7170075371324;759.1838773318705;767.5279702982625;9013;9480.525973701426;9750.452656833668;10222.6422075227;10353.896461035443;587.7854583077146;663.8805015097232;670.5373292428209;686.375398387465;709.4749885085;4607.815687372467;4921.138800709861;4979.6265280104135;5002.59979201663;5052.494750524992;69233;69259;70378;98940;121896.39051804684;99986.50006749919;99990;100058.499707501;100112.49943750381;100279.49860250652;86823.56588217018;88607;89975.55012224897;90292.5485372569;93757.5312123435;9158.313126515404;9539.523023848918;9590.472524010967;9690.127359948812;9785.559649815634;52507.73746131245;53432.73283633557;53472.73263633657;53718.194227087406;54619.72690136683;76341;76714.23285767071;77308;78000.60999694966;79074.20925790668;12093.395330233629;12961.351932403531;13031.47874085026;13160.934195328962;13502.86497135016;14950.102993820406;15306.387744490095;15394.846051539342;15421.306041228396;15542.5337239883;13072.934635326763;13222.206667599974;13981.772030459848;14341.92829035848;14969.625759355667;13756.724865502834;14567.635809104857;14728.26358682083;15256.542303730906;15308.703694445921;13766.793498097337;13989.510367137102;14260.643483912985;14262.286885655469;14670.26648667541;11294.289370551172;11383.772324553629;11530.59642912494;11557.88442115568;11669.649910502698;11391.487383067617;11862.584809531625;12264.632061038183;12414.81377779352;12473.563425280072 07:50:13 INFO - PROCESS | 14152 | __end_tp_report 07:50:13 INFO - PROCESS | 14152 | __start_cc_report 07:50:13 INFO - PROCESS | 14152 | _x_x_mozilla_cycle_collect,1486 07:50:13 INFO - PROCESS | 14152 | __end_cc_report 07:50:13 INFO - PROCESS | 14152 | __startTimestamp1476197413292__endTimestamp 07:50:13 INFO - PROCESS | 14152 | 07:50:13 INFO - PROCESS | 14152 | ------- Summary: start ------- 07:50:13 INFO - PROCESS | 14152 | Number of tests: 6 07:50:13 INFO - PROCESS | 14152 | 07:50:13 INFO - PROCESS | 14152 | [#0] dojo.html Cycles:165 Average:5278.33 Median:5469.89 stddev:601.73 (11.0%) stddev-sans-first:576.96 07:50:13 INFO - PROCESS | 14152 | Values: 3022.2 3057.0 3058.4 3089.5 3107.8 5056.0 5128.9 5254.1 5325.0 5350.1 5180.6 5284.7 5373.4 5402.4 5499.8 4723.1 4854.6 4863.8 4889.4 4900.6 4369.9 4868.6 4890.4 4917.4 4941.2 4938.8 4999.2 5015.0 5045.8 5064.8 4701.1 4729.8 4750.4 4822.0 4896.3 4786.5 4790.9 4790.9 4800.2 4800.3 5206.5 5246.2 5254.3 5297.4 5341.5 5660.2 5661.9 5662.9 5748.6 5752.0 5714.1 5778.6 5781.5 5785.8 5802.5 5099.7 5137.5 5229.7 5266.1 5373.1 5794.8 5812.1 5819.0 5871.6 5884.1 5622.4 5624.2 5625.3 5627.1 5632.2 5492.1 5526.6 5538.1 5664.2 5680.9 5549.4 5595.3 5603.3 5603.4 5605.2 5600.4 5611.0 5611.1 5612.7 5615.6 4307.1 4335.6 4343.9 4344.0 4344.6 3863.9 3898.7 3919.2 3925.0 3925.9 5406.0 5406.9 5410.2 5454.5 5476.7 5704.6 5712.5 5712.7 5722.3 5722.4 5285.3 5351.2 5351.3 5394.3 5469.9 4873.9 4924.6 4926.3 4963.9 5027.5 5912.5 5931.4 5932.9 5935.1 5935.3 5525.0 5715.2 5716.0 5718.5 5724.5 5752.3 5865.7 5910.7 5934.8 6042.4 5648.7 5656.0 5656.4 5663.8 5667.9 5785.6 5793.8 5798.1 5801.7 5802.1 5404.3 5418.9 5426.4 5476.7 5489.0 5454.2 5494.7 5505.9 5507.8 5557.1 5451.7 5498.3 5499.6 5508.3 5583.0 5447.8 5493.4 5516.8 5543.9 5558.3 5463.7 5465.0 5467.6 5468.8 5528.6 07:50:13 INFO - PROCESS | 14152 | 07:50:13 INFO - PROCESS | 14152 | [#1] ext.html Cycles:180 Average:51369.35 Median:19628.67 stddev:96622.07 (492.2%) stddev-sans-first:96817.72 07:50:13 INFO - PROCESS | 14152 | Values: 530.7 579.2 592.8 595.4 598.1 33994.3 41559.8 41960.0 42048.6 44551.3 43291.0 43660.1 43664.2 43724.8 43764.6 8027.3 8743.6 8887.6 8889.8 8896.5 7848.4 8140.5 8146.2 10317.6 10532.7 10731.8 10788.9 10790.7 10793.9 10797.5 10549.2 10613.5 10616.9 10625.5 10627.1 7922.1 8138.3 10057.7 10351.8 10380.8 40017.4 40273.4 40282.0 40339.4 40355.0 3333.0 3448.2 3673.5 3803.6 3894.8 29986.3 30283.4 30290.7 31186.7 31422.0 4043.4 4066.4 4071.5 4105.8 4124.9 236801.0 237315.0 237634.0 237811.0 238191.7 47002.8 48090.5 51529.2 53207.7 54036.5 54277.2 54411.7 54606.0 54614.7 54686.7 16305.9 16462.7 16477.6 16480.4 16493.8 11631.6 12132.2 12143.9 12164.5 12170.9 10855.2 14990.9 15426.6 15440.5 16020.2 5773.6 5777.3 5879.6 5928.4 5963.4 881.4 945.8 1009.1 1077.3 1078.8 30228.2 30794.8 30918.5 31283.4 31487.8 1057.2 1093.9 1148.5 1148.9 1155.4 15477.5 16318.9 16374.8 16714.4 16715.7 488426.0 489014.0 489577.0 489893.0 492809.0 55479.7 55540.0 55689.4 55715.7 55721.7 1185.8 1225.6 1275.7 1320.6 1337.2 28727.6 30618.4 30792.5 30800.4 31238.7 44325.8 44765.6 44765.6 44805.6 44825.0 319727.0 321119.0 321531.0 321952.0 321962.0 26581.9 27542.2 27657.4 28516.4 28608.9 44853.1 45175.0 45490.3 46007.8 46628.0 38260.4 38467.4 38487.8 39042.4 39540.0 38505.0 38741.0 39531.0 39957.6 40097.6 39092.6 39573.2 40076.6 40181.4 40555.8 32106.4 34788.1 34924.3 35018.6 35583.8 26669.2 26723.9 27055.0 27073.9 27224.3 07:50:13 INFO - PROCESS | 14152 | 07:50:13 INFO - PROCESS | 14152 | [#2] jquery.html Cycles:180 Average:29118.50 Median:12592.46 stddev:79559.56 (631.8%) stddev-sans-first:79753.48 07:50:13 INFO - PROCESS | 14152 | Values: 377.9 395.4 405.4 405.5 424.2 13592.4 15662.1 19066.8 19286.9 19865.2 14646.0 14831.3 14877.7 14886.8 16752.5 5491.2 5786.5 5788.6 5793.5 5794.9 5531.3 5607.9 5659.8 5663.1 5698.8 5631.6 5637.7 5639.3 5640.4 5644.3 5361.5 5583.6 5615.4 5617.8 5627.5 5061.2 5066.9 5069.1 5069.3 5073.5 22162.3 22900.2 23047.1 23242.0 23269.9 2010.7 2167.3 2284.7 2343.4 2539.3 10159.3 10258.5 10323.1 10670.5 10811.0 1794.2 1815.5 1831.9 1937.8 1948.4 88151.6 88991.6 89813.0 90770.5 91583.5 10742.8 10820.7 10827.8 11100.8 11323.9 14721.3 15273.8 15304.7 15777.2 15787.4 7974.0 8221.1 8230.8 8402.7 8451.2 7824.7 7867.4 7870.6 8011.7 8161.5 4655.5 4715.3 4789.0 4889.8 4936.6 1817.0 1823.3 1827.1 1857.8 1858.3 786.5 932.4 946.8 985.3 1073.8 18859.0 19221.9 19256.5 19489.8 19820.2 965.1 976.4 985.3 1005.9 1081.9 10020.4 10399.3 10549.4 10621.9 10627.4 467789.0 470845.0 486823.0 487114.0 487825.0 89633.0 91267.0 92469.0 103301.0 106237.5 959.7 994.2 1033.3 1043.3 1047.5 17210.4 17397.7 17990.5 18019.8 18154.5 42736.8 43997.3 44083.6 44406.8 44921.8 59429.4 59642.0 59726.4 60192.0 61163.7 8180.6 8334.3 8434.9 8656.2 8695.5 12508.9 13138.1 13242.7 13305.9 13311.0 11427.3 11475.4 11773.4 11775.4 12065.2 11305.8 11309.6 11353.7 11407.4 11419.0 11606.4 11657.7 11912.4 12012.4 12110.7 8961.2 11521.8 11703.2 11958.7 12016.5 11094.6 12156.9 12300.1 12309.3 12505.2 07:50:13 INFO - PROCESS | 14152 | 07:50:13 INFO - PROCESS | 14152 | [#3] mootools.html Cycles:180 Average:5892.08 Median:4839.96 stddev:3388.77 (70.0%) stddev-sans-first:3381.57 07:50:13 INFO - PROCESS | 14152 | Values: 1414.1 1451.0 1568.7 1690.9 1774.7 8594.2 9234.0 9234.3 9275.9 9281.0 7886.3 8112.6 8557.1 8733.1 8740.6 2340.4 2366.9 2374.3 2376.0 2377.4 2323.7 2341.5 2362.4 2366.1 2366.6 1889.2 1928.9 1930.1 1944.5 2283.4 2329.8 2379.2 2380.9 2382.3 2383.2 2278.9 2307.7 2309.0 2319.8 2328.9 9104.1 9159.3 9164.0 9168.2 9173.4 5029.5 5156.9 5206.6 5213.3 5214.3 3344.3 3417.8 3494.9 3504.3 3517.9 1159.2 1195.7 1219.6 1231.9 1235.3 12884.4 12887.6 12899.8 12906.7 12908.9 4621.6 4825.2 4833.2 4835.8 4844.1 10779.5 10793.8 10830.2 10830.4 10851.5 5276.1 5292.3 5306.1 5332.8 5343.9 4806.0 4808.1 4824.1 4865.4 4951.2 3948.4 3958.7 4021.0 4094.5 4104.4 1305.4 1314.3 1321.1 1340.9 1342.0 893.5 906.3 926.9 927.0 931.4 6033.2 6036.8 6162.5 6451.0 6499.6 888.9 895.5 907.7 909.5 915.3 4046.2 4122.2 4167.3 4237.1 4258.6 10787.9 11225.6 11240.9 11243.2 11252.0 10577.7 11163.9 11175.4 11176.2 11189.4 7930.6 8351.0 8353.5 8354.3 8355.0 5999.0 6024.6 6025.8 6176.1 6464.3 9687.9 10094.5 10143.3 10220.4 10245.7 10231.0 10354.7 10384.9 10483.0 10497.3 7779.7 7923.0 7990.6 8008.6 8091.8 8538.4 8685.3 8690.4 8694.1 8713.3 7424.6 7546.0 7558.7 7559.9 7688.0 7195.9 7217.4 7372.2 7400.4 7494.1 7321.0 7333.0 7411.5 7411.6 7417.9 5109.0 5159.4 5160.0 5206.2 5251.7 5145.3 5175.3 5251.5 5277.8 5324.8 07:50:13 INFO - PROCESS | 14152 | 07:50:13 INFO - PROCESS | 14152 | [#4] prototype.html Cycles:180 Average:4661.05 Median:5365.35 stddev:1374.54 (25.6%) stddev-sans-first:1339.31 07:50:13 INFO - PROCESS | 14152 | Values: 324.7 333.9 336.4 336.9 340.2 5282.2 5295.1 5318.9 5320.3 5381.7 5261.4 5283.4 5309.4 5314.0 5323.8 3983.9 4040.3 4086.3 4108.9 4147.4 4110.3 4115.1 4116.3 4127.3 4131.2 4055.9 4094.5 4104.1 4106.9 4141.9 3939.9 3958.7 4027.7 4118.4 4129.4 3668.3 3668.5 3685.8 3687.1 3705.3 5041.3 5089.6 5100.5 5107.9 5150.5 4486.6 4724.0 4726.1 4741.9 4752.8 5520.6 5529.8 5531.6 5540.9 5552.0 3996.5 4007.0 4012.2 4013.3 4031.3 5557.7 5682.7 5717.1 5718.0 5765.2 4045.1 4047.6 4049.5 4054.2 4069.3 4108.7 4109.7 4112.7 4115.7 4126.9 4591.9 4678.2 4701.8 4716.9 4723.0 5491.6 5530.9 5535.8 5567.7 5571.5 1407.7 1425.9 1426.9 1428.8 1431.8 844.8 889.2 890.2 900.7 902.3 5101.8 5223.3 5254.2 5373.3 5382.6 5676.5 5676.9 5687.7 5688.3 5702.5 5188.3 5358.0 5372.7 5395.6 5396.2 2990.6 3006.6 3012.9 3018.2 3019.2 5881.9 5885.5 5900.5 5910.3 5940.9 5632.9 5794.5 5796.5 5803.0 5804.8 5871.2 5879.5 5897.5 5908.7 5911.9 5382.8 5580.4 5653.9 5662.9 5676.7 5573.9 5584.3 5593.6 5610.7 5628.9 5881.4 5882.4 5888.7 5905.4 5909.3 3855.4 3993.6 4067.1 4068.7 4075.5 5604.3 5613.2 5622.3 5632.7 5648.5 5404.6 5504.2 5528.2 5547.3 5555.4 5312.7 5531.4 5565.7 5584.7 5588.7 5547.6 5553.6 5556.6 5557.6 5588.2 5309.4 5453.9 5488.2 5573.2 5586.9 5455.8 5456.7 5458.4 5459.3 5462.7 07:50:13 INFO - PROCESS | 14152 | 07:50:13 INFO - PROCESS | 14152 | [#5] yui.html Cycles:180 Average:20591.85 Median:4853.89 stddev:28739.17 (592.1%) stddev-sans-first:28781.11 07:50:13 INFO - PROCESS | 14152 | Values: 735.9 768.8 792.7 815.9 828.6 15240.0 15813.0 16002.3 16050.9 16906.8 15268.6 15439.8 15461.8 15541.4 15597.2 650.6 675.3 787.7 811.4 816.9 794.2 816.2 824.9 825.9 826.6 877.0 879.8 880.3 880.6 881.1 680.7 706.9 876.3 876.6 877.0 611.8 628.0 633.5 634.1 634.3 14969.6 14988.3 14989.9 15012.9 15027.7 13918.7 14043.6 14394.7 14489.6 14760.9 12589.0 12714.6 12800.9 12912.4 12926.5 4225.5 4242.4 4286.5 4310.3 4335.8 81303.2 81491.6 81617.6 82115.0 83866.6 10829.4 11061.6 11438.8 11491.9 11746.9 20691.9 20741.6 20799.2 20949.2 21018.9 7198.2 7702.0 7961.2 8591.7 8617.4 4487.8 4673.7 4703.1 4834.4 4873.4 3749.9 3845.6 3909.5 3910.6 3911.1 684.4 685.0 693.0 706.6 710.4 716.2 733.0 744.7 759.2 767.5 9013.0 9480.5 9750.5 10222.6 10353.9 587.8 663.9 670.5 686.4 709.5 4607.8 4921.1 4979.6 5002.6 5052.5 69233.0 69259.0 70378.0 98940.0 121896.4 99986.5 99990.0 100058.5 100112.5 100279.5 86823.6 88607.0 89975.6 90292.5 93757.5 9158.3 9539.5 9590.5 9690.1 9785.6 52507.7 53432.7 53472.7 53718.2 54619.7 76341.0 76714.2 77308.0 78000.6 79074.2 12093.4 12961.4 13031.5 13160.9 13502.9 14950.1 15306.4 15394.8 15421.3 15542.5 13072.9 13222.2 13981.8 14341.9 14969.6 13756.7 14567.6 14728.3 15256.5 15308.7 13766.8 13989.5 14260.6 14262.3 14670.3 11294.3 11383.8 11530.6 11557.9 11669.6 11391.5 11862.6 12264.6 12414.8 12473.6 07:50:13 INFO - PROCESS | 14152 | -------- Summary: end -------- 07:50:13 INFO - PROCESS | 14152 | 07:50:14 INFO - TEST-INFO | 14152: exit 0 07:50:14 INFO - TEST-OK | dromaeo_css | took 1118296ms 07:50:14 INFO - TEST-START | kraken 07:50:14 INFO - operating with platform_type : linux_ 07:50:14 INFO - Initialising browser for kraken test... 07:50:14 INFO - TEST-INFO | started process 14488 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_OoQBv/profile http://localhost:54681/getInfo.html) 07:50:18 INFO - PROCESS | 14488 | __metrics Screen width/height:1600/1200 07:50:18 INFO - PROCESS | 14488 | colorDepth:24 07:50:18 INFO - PROCESS | 14488 | Browser inner width/height: 1024/697 07:50:18 INFO - PROCESS | 14488 | __metrics 07:50:19 INFO - PROCESS | 14488 | 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" 07:50:19 INFO - PROCESS | 14488 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:50:19 INFO - PROCESS | 14488 | console.error: PushService: 07:50:19 INFO - PROCESS | 14488 | stateChangeProcessEnqueue: Error transitioning state 07:50:19 INFO - PROCESS | 14488 | UnknownError 07:50:20 INFO - TEST-INFO | 14488: exit 0 07:50:20 INFO - Browser initialized. 07:50:20 INFO - Running cycle 1/1 for kraken test... 07:50:20 INFO - TEST-INFO | started process 14571 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_OoQBv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:50:32 INFO - PROCESS | 14571 | RSS: Main: 172929024 07:50:32 INFO - PROCESS | 14571 | 07:50:35 INFO - PROCESS | 14571 | Cycle 1(1): loaded http://localhost:54681/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54681/tests/kraken/driver.html?testName=audio-beat-detection) 07:50:35 INFO - PROCESS | 14571 | RSS: Main: 231333888 07:50:35 INFO - PROCESS | 14571 | 07:50:38 INFO - PROCESS | 14571 | Cycle 1(1): loaded http://localhost:54681/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54681/tests/kraken/driver.html?testName=audio-dft) 07:50:39 INFO - PROCESS | 14571 | RSS: Main: 216604672 07:50:39 INFO - PROCESS | 14571 | 07:50:42 INFO - PROCESS | 14571 | Cycle 1(1): loaded http://localhost:54681/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54681/tests/kraken/driver.html?testName=audio-fft) 07:50:42 INFO - PROCESS | 14571 | RSS: Main: 298397696 07:50:42 INFO - PROCESS | 14571 | 07:50:45 INFO - PROCESS | 14571 | Cycle 1(1): loaded http://localhost:54681/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54681/tests/kraken/driver.html?testName=audio-oscillator) 07:50:45 INFO - PROCESS | 14571 | RSS: Main: 209338368 07:50:45 INFO - PROCESS | 14571 | 07:50:47 INFO - PROCESS | 14571 | Cycle 1(1): loaded http://localhost:54681/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54681/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:50:48 INFO - PROCESS | 14571 | RSS: Main: 212570112 07:50:48 INFO - PROCESS | 14571 | 07:50:51 INFO - PROCESS | 14571 | Cycle 1(1): loaded http://localhost:54681/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54681/tests/kraken/driver.html?testName=imaging-darkroom) 07:50:51 INFO - PROCESS | 14571 | RSS: Main: 248688640 07:50:51 INFO - PROCESS | 14571 | 07:50:55 INFO - PROCESS | 14571 | Cycle 1(1): loaded http://localhost:54681/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54681/tests/kraken/driver.html?testName=imaging-desaturate) 07:50:55 INFO - PROCESS | 14571 | RSS: Main: 248410112 07:50:55 INFO - PROCESS | 14571 | 07:50:58 INFO - PROCESS | 14571 | Cycle 1(1): loaded http://localhost:54681/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54681/tests/kraken/driver.html?testName=json-parse-financial) 07:50:59 INFO - PROCESS | 14571 | RSS: Main: 247533568 07:50:59 INFO - PROCESS | 14571 | 07:51:00 INFO - PROCESS | 14571 | Cycle 1(1): loaded http://localhost:54681/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54681/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:51:01 INFO - PROCESS | 14571 | RSS: Main: 209563648 07:51:01 INFO - PROCESS | 14571 | 07:51:03 INFO - PROCESS | 14571 | Cycle 1(1): loaded http://localhost:54681/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54681/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:51:03 INFO - PROCESS | 14571 | RSS: Main: 216911872 07:51:03 INFO - PROCESS | 14571 | 07:51:05 INFO - PROCESS | 14571 | Cycle 1(1): loaded http://localhost:54681/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54681/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:51:06 INFO - PROCESS | 14571 | RSS: Main: 225964032 07:51:06 INFO - PROCESS | 14571 | 07:51:08 INFO - PROCESS | 14571 | Cycle 1(1): loaded http://localhost:54681/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54681/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:51:09 INFO - PROCESS | 14571 | RSS: Main: 234909696 07:51:09 INFO - PROCESS | 14571 | 07:51:12 INFO - PROCESS | 14571 | Cycle 1(1): loaded http://localhost:54681/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54681/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:51:13 INFO - PROCESS | 14571 | RSS: Main: 231854080 07:51:13 INFO - PROCESS | 14571 | 07:51:14 INFO - PROCESS | 14571 | Cycle 1(1): loaded http://localhost:54681/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54681/tests/kraken/driver.html?testName=ai-astar) 07:51:15 INFO - PROCESS | 14571 | RSS: Main: 283316224 07:51:15 INFO - PROCESS | 14571 | 07:51:15 INFO - PROCESS | 14571 | __start_tp_report 07:51:15 INFO - PROCESS | 14571 | _x_x_mozilla_page_load 07:51:15 INFO - PROCESS | 14571 | _x_x_mozilla_page_load_details 07:51:15 INFO - PROCESS | 14571 | |i|pagename|runs| 07:51:15 INFO - PROCESS | 14571 | |0;ai-astar;109;111;112;111;112;111;111;110;111;112 07:51:15 INFO - PROCESS | 14571 | |1;audio-beat-detection;150;125;121;165;120;124;127;126;155;120 07:51:15 INFO - PROCESS | 14571 | |2;audio-dft;161;160;162;159;160;161;161;162;162;162 07:51:15 INFO - PROCESS | 14571 | |3;audio-fft;75;75;75;120;80;76;75;75;113;75 07:51:15 INFO - PROCESS | 14571 | |4;audio-oscillator;83;83;119;82;82;82;119;82;82;119 07:51:15 INFO - PROCESS | 14571 | |5;imaging-gaussian-blur;118;117;117;118;117;117;117;118;117;117 07:51:15 INFO - PROCESS | 14571 | |6;imaging-darkroom;147;145;145;146;146;145;145;145;146;145 07:51:15 INFO - PROCESS | 14571 | |7;imaging-desaturate;96;95;95;95;95;95;95;94;96;95 07:51:15 INFO - PROCESS | 14571 | |8;json-parse-financial;53;51;52;51;52;52;53;53;52;53 07:51:15 INFO - PROCESS | 14571 | |9;json-stringify-tinderbox;61;62;62;63;62;61;61;62;61;62 07:51:15 INFO - PROCESS | 14571 | |10;stanford-crypto-aes;79;80;79;80;80;80;79;80;88;79 07:51:15 INFO - PROCESS | 14571 | |11;stanford-crypto-ccm;141;131;139;127;141;132;137;144;167;132 07:51:15 INFO - PROCESS | 14571 | |12;stanford-crypto-pbkdf2;166;170;165;165;170;164;170;165;164;165 07:51:15 INFO - PROCESS | 14571 | |13;stanford-crypto-sha256-iterative;65;69;68;65;69;69;70;65;72;65 07:51:15 INFO - PROCESS | 14571 | __end_tp_report 07:51:15 INFO - PROCESS | 14571 | __start_cc_report 07:51:15 INFO - PROCESS | 14571 | _x_x_mozilla_cycle_collect,1697 07:51:15 INFO - PROCESS | 14571 | __end_cc_report 07:51:15 INFO - PROCESS | 14571 | __startTimestamp1476197475050__endTimestamp 07:51:15 INFO - PROCESS | 14571 | 07:51:15 INFO - PROCESS | 14571 | ------- Summary: start ------- 07:51:15 INFO - PROCESS | 14571 | Number of tests: 14 07:51:15 INFO - PROCESS | 14571 | 07:51:15 INFO - PROCESS | 14571 | [#0] ai-astar Cycles:10 Average:111.00 Median:111.00 stddev:0.94 (0.8%) stddev-sans-first:0.67 07:51:15 INFO - PROCESS | 14571 | Values: 109.0 111.0 112.0 111.0 112.0 111.0 111.0 110.0 111.0 112.0 07:51:15 INFO - PROCESS | 14571 | 07:51:15 INFO - PROCESS | 14571 | [#1] audio-beat-detection Cycles:10 Average:133.30 Median:126.50 stddev:16.69 (13.2%) stddev-sans-first:16.58 07:51:15 INFO - PROCESS | 14571 | Values: 150.0 125.0 121.0 165.0 120.0 124.0 127.0 126.0 155.0 120.0 07:51:15 INFO - PROCESS | 14571 | 07:51:15 INFO - PROCESS | 14571 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.50 stddev:1.05 (0.7%) stddev-sans-first:1.12 07:51:15 INFO - PROCESS | 14571 | Values: 161.0 160.0 162.0 159.0 160.0 161.0 161.0 162.0 162.0 162.0 07:51:15 INFO - PROCESS | 14571 | 07:51:15 INFO - PROCESS | 14571 | [#3] audio-fft Cycles:10 Average:83.90 Median:75.00 stddev:17.33 (23.1%) stddev-sans-first:18.08 07:51:15 INFO - PROCESS | 14571 | Values: 75.0 75.0 75.0 120.0 80.0 76.0 75.0 75.0 113.0 75.0 07:51:15 INFO - PROCESS | 14571 | 07:51:15 INFO - PROCESS | 14571 | [#4] audio-oscillator Cycles:10 Average:93.30 Median:82.00 stddev:17.74 (21.6%) stddev-sans-first:18.42 07:51:15 INFO - PROCESS | 14571 | Values: 83.0 83.0 119.0 82.0 82.0 82.0 119.0 82.0 82.0 119.0 07:51:15 INFO - PROCESS | 14571 | 07:51:15 INFO - PROCESS | 14571 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 07:51:15 INFO - PROCESS | 14571 | Values: 118.0 117.0 117.0 118.0 117.0 117.0 117.0 118.0 117.0 117.0 07:51:15 INFO - PROCESS | 14571 | 07:51:15 INFO - PROCESS | 14571 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.50 07:51:15 INFO - PROCESS | 14571 | Values: 147.0 145.0 145.0 146.0 146.0 145.0 145.0 145.0 146.0 145.0 07:51:15 INFO - PROCESS | 14571 | 07:51:15 INFO - PROCESS | 14571 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 07:51:15 INFO - PROCESS | 14571 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 96.0 95.0 07:51:15 INFO - PROCESS | 14571 | 07:51:15 INFO - PROCESS | 14571 | [#8] json-parse-financial Cycles:10 Average:52.20 Median:52.50 stddev:0.79 (1.5%) stddev-sans-first:0.78 07:51:15 INFO - PROCESS | 14571 | Values: 53.0 51.0 52.0 51.0 52.0 52.0 53.0 53.0 52.0 53.0 07:51:15 INFO - PROCESS | 14571 | 07:51:15 INFO - PROCESS | 14571 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:62.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 07:51:15 INFO - PROCESS | 14571 | Values: 61.0 62.0 62.0 63.0 62.0 61.0 61.0 62.0 61.0 62.0 07:51:15 INFO - PROCESS | 14571 | 07:51:15 INFO - PROCESS | 14571 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:80.00 stddev:2.72 (3.4%) stddev-sans-first:2.83 07:51:15 INFO - PROCESS | 14571 | Values: 79.0 80.0 79.0 80.0 80.0 80.0 79.0 80.0 88.0 79.0 07:51:15 INFO - PROCESS | 14571 | 07:51:15 INFO - PROCESS | 14571 | [#11] stanford-crypto-ccm Cycles:10 Average:139.10 Median:140.00 stddev:11.19 (8.0%) stddev-sans-first:11.85 07:51:15 INFO - PROCESS | 14571 | Values: 141.0 131.0 139.0 127.0 141.0 132.0 137.0 144.0 167.0 132.0 07:51:15 INFO - PROCESS | 14571 | 07:51:15 INFO - PROCESS | 14571 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.40 Median:165.50 stddev:2.55 (1.5%) stddev-sans-first:2.70 07:51:15 INFO - PROCESS | 14571 | Values: 166.0 170.0 165.0 165.0 170.0 164.0 170.0 165.0 164.0 165.0 07:51:15 INFO - PROCESS | 14571 | 07:51:15 INFO - PROCESS | 14571 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:69.00 stddev:2.54 (3.7%) stddev-sans-first:2.50 07:51:15 INFO - PROCESS | 14571 | Values: 65.0 69.0 68.0 65.0 69.0 69.0 70.0 65.0 72.0 65.0 07:51:15 INFO - PROCESS | 14571 | -------- Summary: end -------- 07:51:15 INFO - PROCESS | 14571 | 07:51:16 INFO - TEST-INFO | 14571: exit 0 07:51:16 INFO - TEST-OK | kraken | took 62037ms 07:51:16 INFO - SUITE-END | took 1180s 07:51:16 INFO - Completed test suite (00:19:40) 07:51:16 INFO - javascript benchmark 07:51:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3022.2444388902773, 3056.984715076425, 3058.3577448735764, 3089.536569514574, 3107.7669174811895, 5056.014077254937, 5128.948710512894, 5254.054270231357, 5325.0, 5350.063738845701, 5180.559652429539, 5284.656497327681, 5373.382061062979, 5402.405735369116, 5499.807506737255, 4723.07899959508, 4854.56308932196, 4863.805447782084, 4889.437714662815, 4900.58345040672, 4369.866072489047, 4868.610511159117, 4890.388701412324, 4917.4099108107075, 4941.160002799515, 4938.777755001033, 4999.200127979524, 5014.974925125388, 5045.823396181135, 5064.822731204408, 4701.106789709944, 4729.810807567693, 4750.358701575277, 4822.011487645024, 4896.314515967767, 4786.497417771118, 4790.880227994293, 4790.928136077961, 4800.207965685658, 4800.279958006292, 5206.479352064801, 5246.213068039825, 5254.290670759437, 5297.443768404339, 5341.4925582069645, 5660.179274005246, 5661.8584535386535, 5662.943370566324, 5748.626339287975, 5752.0, 5714.142878568248, 5778.566607504454, 5781.53747700183, 5785.768569257225, 5802.477777000048, 5099.71951542665, 5137.537621614073, 5229.6600720953775, 5266.052110620049, 5373.113436283009, 5794.82615521535, 5812.128180772918, 5819.039858423397, 5871.6183448075735, 5884.08796636522, 5622.353429355595, 5624.240727501817, 5625.296837895263, 5627.127795191752, 5632.239647647515, 5492.1212605982855, 5526.640768350045, 5538.0585300499015, 5664.178694089334, 5680.943190568041, 5549.417311182348, 5595.300587426572, 5603.299587551556, 5603.35561410443, 5605.215269862222, 5600.411956744483, 5610.97194514033, 5611.102223644198, 5612.663240205601, 5615.550755939515, 4307.095509942885, 4335.609795118455, 4343.891402714958, 4344.0, 4344.6089851913475, 3863.9034024149623, 3898.6686131679126, 3919.2161567686576, 3924.9803750981064, 3925.941110883282, 5405.972970135124, 5406.8918621627345, 5410.242566040757, 5454.481824226692, 5476.726163691879, 5704.600677952503, 5712.457316554921, 5712.742926568231, 5722.341930678025, 5722.37053924068, 5285.2600635911, 5351.224072509543, 5351.25082488452, 5394.32570928634, 5469.890602187934, 4873.902521949542, 4924.556789888928, 4926.261060840902, 4963.851084467472, 5027.547520723152, 5912.46787789101, 5931.377205393458, 5932.940670593325, 5935.0503919372695, 5935.2877654681715, 5525.0, 5715.199872017838, 5715.999700052557, 5718.542516598579, 5724.484796368347, 5752.33848107473, 5865.706714664335, 5910.674912879833, 5934.762609495572, 6042.425969532887, 5648.661080335193, 5655.971720141373, 5656.43435656431, 5663.773449062156, 5667.943320566742, 5785.56608254391, 5793.797217097382, 5798.072308430799, 5801.709914504342, 5802.1296805479515, 5404.32445944257, 5418.885621174731, 5426.403095659553, 5476.67139971603, 5489.039418101896, 5454.181872719124, 5494.670319780826, 5505.944940550543, 5507.807226747044, 5557.138643510262, 5451.7274136292235, 5498.340199176125, 5499.587530935116, 5508.338999320107, 5582.972085139549, 5447.782088716407, 5493.423190564933, 5516.806911758069, 5543.944560554504, 5558.333000040021, 5463.72681365938, 5465.0, 5467.617266791286, 5468.835934921959, 5528.585356098389], "value": 5237.7691600128055, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [530.6837793604147, 579.1631093070512, 592.792522617084, 595.4343373794893, 598.064029793373, 33994.320113597714, 41559.79220103899, 41960.0, 42048.57951420489, 44551.331730023994, 43291.0, 43660.12679746403, 43664.16182948106, 43724.78137609307, 43764.562354376445, 8027.317677997377, 8743.562821858914, 8887.644494220256, 8889.822203555925, 8896.466212027266, 7848.372130229568, 8140.4708693935, 8146.2261085196815, 10317.58729650813, 10532.736681582945, 10731.83902241467, 10788.946055269713, 10790.676279711583, 10793.892061079367, 10797.460126993657, 10549.156067514581, 10613.469326533643, 10616.893831061669, 10625.5218515167, 10627.096696780784, 7922.128565857751, 8138.348932085419, 10057.748556286078, 10351.792964140675, 10380.844287335696, 40017.39973900394, 40273.395899061536, 40282.0, 40339.394909076385, 40355.0, 3332.950005749916, 3448.189675426273, 3673.522442082539, 3803.6386543278345, 3894.805259737002, 29986.25034374136, 30283.394332113454, 30290.697093029008, 31186.68813311883, 31422.0, 4043.3732771420478, 4066.410370496291, 4071.531773845986, 4105.753654780723, 4124.9381259280835, 236801.0, 237315.0, 237634.0, 237811.0, 238191.7084974907, 47002.76498617485, 48090.5190948093, 51529.22706159411, 53207.73396132995, 54036.459635403146, 54277.1858422124, 54411.727941360834, 54606.0, 54614.72692636511, 54686.72656636692, 16305.918470407572, 16462.670746585, 16477.58806029859, 16480.4231851887, 16493.752593711102, 11631.59289424866, 12132.150749447454, 12143.939280303543, 12164.452599632861, 12170.878291216974, 10855.185861060452, 14990.850091498945, 15426.614334641723, 15440.45958391451, 16020.19899005045, 5773.566982476331, 5777.340175836356, 5879.559033072536, 5928.407159284124, 5963.373845746134, 881.38743573216, 945.7541039329824, 1009.0867764672983, 1077.2943721862193, 1078.8166011778017, 30228.24429389283, 30794.846025769726, 30918.53622195669, 31283.374332513224, 31487.84256078705, 1057.2440704896037, 1093.8577984862077, 1148.534843388429, 1148.9195756296979, 1155.422288855572, 15477.458288959833, 16318.918405408134, 16374.754378684329, 16714.4149954751, 16715.749263761052, 488426.0, 489014.0, 489577.0, 489893.0, 492809.0, 55479.72260138673, 55540.0, 55689.44310556923, 55715.72142139344, 55721.721391392784, 1185.7707509881368, 1225.5955534673537, 1275.655572995286, 1320.5774152271374, 1337.1709540085403, 28727.569086463303, 30618.387632246784, 30792.53811192879, 30800.383992320476, 31238.687613123577, 44325.77837110794, 44765.552344476135, 44765.628124625255, 44805.55194448014, 44825.0, 319727.0, 321119.0, 321531.0, 321952.0, 321962.0, 26581.867090664422, 27542.17373478799, 27657.44685106327, 28516.42967140604, 28608.856955715088, 44853.10293794171, 45175.0, 45490.31764523601, 46007.76996114998, 46628.0, 38260.42609360806, 38467.42298865463, 38487.807560963134, 39042.41436378514, 39540.0, 38505.0, 38741.0, 39531.0, 39957.60042399539, 40097.59902401055, 39092.60907391003, 39573.20853582855, 40076.599234007284, 40181.39727904142, 40555.79722101371, 32106.35787284288, 34788.130296742784, 34924.30151397009, 35018.649813501535, 35583.82208088943, 26669.19992400231, 26723.866380667972, 27055.0, 27073.864630676722, 27224.319392015357], "value": 18997.848462771883, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.87718991327824, 395.3891238037234, 405.42024904386733, 405.4566880380291, 424.1749796645524, 13592.388342524599, 15662.138582377964, 19066.809331906694, 19286.903565482153, 19865.20539178431, 14646.0, 14831.258437078157, 14877.702445951074, 14886.766984952235, 16752.49742507727, 5491.203775452567, 5786.537077033827, 5788.623739456922, 5793.536517078624, 5794.884102317951, 5531.2532808071, 5607.8878422431735, 5659.830205093854, 5663.0655941769555, 5698.772049118051, 5631.60578759487, 5637.689927054011, 5639.2668953036255, 5640.407757185498, 5644.294463192101, 5361.490658387466, 5583.609147359707, 5615.438456154393, 5617.831465056055, 5627.493525582717, 5061.190209566488, 5066.923996140061, 5069.06222348863, 5069.290299358093, 5073.543381095719, 22162.33512994613, 22900.19849305283, 23047.081996060544, 23242.0, 23269.88365058164, 2010.6581881080251, 2167.295628920607, 2284.725832900046, 2343.4024323797494, 2539.3016920347054, 10159.33964292326, 10258.538365773558, 10323.122534584494, 10670.466476676134, 10811.0, 1794.246416505058, 1815.546113471632, 1831.9084045797656, 1937.8352840008615, 1948.3959972408456, 88151.55924220402, 88991.55504222566, 89813.0, 90770.54614726885, 91583.54208228983, 10742.83885741699, 10820.729481763019, 10827.78344433107, 11100.833487497694, 11323.886761132284, 14721.33753981052, 15273.770893436607, 15304.693906121815, 15777.211139442981, 15787.447439339798, 7973.960130199428, 8221.095679475253, 8230.753077407688, 8402.705905293285, 8451.197136272045, 7824.687012519549, 7867.370610351159, 7870.645820938072, 8011.719589814328, 8161.469504482189, 4655.511171326962, 4715.3024911032, 4788.976055119702, 4889.755512224375, 4936.6297527685565, 1816.9909150454164, 1823.2615790604825, 1827.1229809691156, 1857.76139751599, 1858.27527264367, 786.4691333349966, 932.3520153493392, 946.8011717539393, 985.3152059318847, 1073.8228192348174, 18859.0, 19221.90389048074, 19256.518587035436, 19489.80510194908, 19820.20719171217, 965.0879918476971, 976.3751199232497, 985.2905907746411, 1005.8893521712606, 1081.9134469242442, 10020.398776073458, 10399.32404393712, 10549.367037977747, 10621.893781062245, 10627.36235825853, 467789.0, 470845.0, 486823.0, 487114.0, 487825.0, 89633.0, 91267.0, 92469.0, 103301.0, 106237.46881265698, 959.7360725800461, 994.2409812769478, 1033.338663255517, 1043.3479075577764, 1047.4972013433594, 17210.39763608268, 17397.739033914248, 17990.460286191435, 18019.819801801816, 18154.455366339032, 42736.78631606822, 43997.34003989879, 44083.55916440795, 44406.779661016175, 44921.775391122836, 59429.40570594239, 59642.0, 59726.402735972086, 60192.0, 61163.69418152881, 8180.590970451334, 8334.291585215324, 8434.873476897974, 8656.22094011542, 8695.521746304014, 12508.937455312665, 13138.146020508637, 13242.735145297233, 13305.871060630252, 13311.0, 11427.257228280136, 11475.368854713071, 11773.411329433666, 11775.411229438665, 12065.155439119177, 11305.773884522428, 11309.604163854226, 11353.716157095809, 11407.429628518707, 11419.0, 11606.419679015846, 11657.708557286136, 11912.40437978115, 12012.399380031138, 12110.697232569257, 8961.193492585699, 11521.769564608494, 11703.23928944616, 11958.701032474257, 12016.459259333176, 11094.5562177512, 12156.878431215575, 12300.138990270596, 12309.32298723543, 12505.249685018927], "value": 9196.342114732339, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1414.0688884899978, 1450.9637259068522, 1568.6705791783725, 1690.8900921440097, 1774.6628140653274, 8594.183552562505, 9234.03042680519, 9234.261259099281, 9275.907240927589, 9281.0, 7886.29023387895, 8112.5943702814775, 8557.101504342048, 8733.126687331263, 8740.606672699729, 2340.356401989454, 2366.8993917828207, 2374.3351861478814, 2376.0377047295788, 2377.405648587853, 2323.744388117306, 2341.508283260517, 2362.4093976505874, 2366.100881664965, 2366.645003249509, 1889.1782074797438, 1928.8746231494908, 1930.1025023364202, 1944.4944314478196, 2283.4177284792354, 2329.755375685554, 2379.1910750344964, 2380.8928598213124, 2382.285314405671, 2383.2492764779126, 2278.8632682038965, 2307.723073231223, 2309.041747674713, 2319.7680231976838, 2328.918487852934, 9104.089591040909, 9159.267258619295, 9163.98392353681, 9168.220701240403, 9173.40372875761, 5029.522195391469, 5156.871078223037, 5206.583473322125, 5213.296205012312, 5214.296070030536, 3344.347852168828, 3417.7778444401283, 3494.899106781356, 3504.299140171976, 3517.9472307915403, 1159.2059439284117, 1195.6532605544382, 1219.5731493977125, 1231.870653581379, 1235.3390935849277, 12884.355782210945, 12887.613371598867, 12899.806502902464, 12906.677333066655, 12908.87091129086, 4621.584057434779, 4825.179719447702, 4833.178359678863, 4835.8065677373215, 4844.103840789465, 10779.514921828537, 10793.83809242862, 10830.241883068109, 10830.350178989285, 10851.45742712877, 5276.129438642658, 5292.285541451932, 5306.09796334624, 5332.760025798849, 5343.919841202385, 4806.038792241566, 4808.08646357198, 4824.131656301899, 4865.416150062015, 4951.183054795991, 3948.4274780156716, 3958.7030972677167, 4020.9597904020584, 4094.5495995441074, 4104.445899803548, 1305.4451857960328, 1314.2968511846116, 1321.0818481155504, 1340.9463621455031, 1342.0404410846293, 893.5442924108621, 906.2613969614742, 926.8748718922994, 927.0, 931.3666706639415, 6033.185519954838, 6036.8188954331445, 6162.506999440034, 6451.0, 6499.642519661369, 888.9199972002551, 895.5298468304193, 907.6777743900952, 909.5497728624373, 915.2769312243254, 4046.1705350403095, 4122.175564887035, 4167.270727622654, 4237.110206856533, 4258.5954334338185, 10787.892121078688, 11225.550977960953, 11240.887591124148, 11243.156763242789, 11251.987321141136, 10577.735556611146, 11163.888361116447, 11175.385353805455, 11176.217664763388, 11189.384583847966, 7930.6431210595665, 8350.958245208734, 8353.540555269397, 8354.331653467829, 8354.958225208957, 5999.0, 6024.578279520391, 6025.849353766191, 6176.135341052346, 6464.2889282177985, 9687.854682179914, 10094.495275236062, 10143.34068285559, 10220.386776793417, 10245.692629221136, 10231.0, 10354.689359319233, 10384.896151038392, 10482.951704829457, 10497.317674351143, 7779.688812447665, 7923.0, 7990.560519171501, 8008.639611217625, 8091.797705057421, 8538.402311838112, 8685.305175586065, 8690.391672583111, 8694.130586941255, 8713.346499012472, 7424.587009221917, 7546.0, 7558.697652093854, 7559.886601701089, 7687.961560192387, 7195.928040719526, 7217.422606191597, 7372.225916278713, 7400.444966627417, 7494.138174110047, 7321.048263725682, 7333.01004364404, 7411.518251313647, 7411.62941852916, 7417.851642967003, 5108.974455127701, 5159.380874295109, 5159.974200128975, 5206.219067139959, 5251.71115588631, 5145.331106956071, 5175.301334319819, 5251.474852514871, 5277.788888444419, 5324.840254792362], "value": 4689.212925948579, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.701274827159, 333.8781344809144, 336.35755706600366, 336.9258763072124, 340.18525631113476, 5282.23407605897, 5295.146698655469, 5318.89362212756, 5320.281761962134, 5381.650192737469, 5261.421243663194, 5283.392409872866, 5309.41596424393, 5314.0, 5323.787048518055, 3983.8645985893954, 4040.2929487339743, 4086.346184610463, 4108.917821643566, 4147.440095587102, 4110.321796903508, 4115.115250221202, 4116.259073366793, 4127.277726397883, 4131.2442212059905, 4055.8909367129077, 4094.488188976378, 4104.117614712836, 4106.850081977052, 4141.896452588694, 3939.9212015759667, 3958.663513601333, 4027.6979226558124, 4118.402831589403, 4129.380592911058, 3668.284684486526, 3668.5047518584915, 3685.7652686350107, 3687.1335236219734, 3705.3330400527893, 5041.319421878073, 5089.592832573385, 5100.5409513143995, 5107.923381149286, 5150.484951504857, 4486.631577368901, 4723.976380118077, 4726.125666751662, 4741.881452963669, 4752.809887604491, 5520.641158324696, 5529.751161197756, 5531.585131115183, 5540.9168862467095, 5551.9722401388135, 3996.480457540501, 4006.979965100156, 4012.1775036117524, 4013.3177359848896, 4031.294523458383, 5557.749901254413, 5682.687452190128, 5717.142428635696, 5717.9714101429645, 5765.221695071195, 4045.110075783323, 4047.5547689754103, 4049.493813273341, 4054.2094291612852, 4069.2908978229216, 4108.650764685035, 4109.691773117028, 4112.691548133902, 4115.650169735606, 4126.8761937141935, 4591.862244132682, 4678.204705200124, 4701.811927522861, 4716.905661886812, 4723.0, 5491.643043202179, 5530.86172845674, 5535.833924982257, 5567.749451274703, 5571.526420254243, 1407.7043820797542, 1425.9091794777005, 1426.8715815576647, 1428.821222491428, 1431.8281806183325, 844.7676888855614, 889.2397000564554, 890.1543533643065, 900.7162743735702, 902.2917010147003, 5101.795928162906, 5223.268742376071, 5254.185601231815, 5373.328333958255, 5382.596305277041, 5676.545876329884, 5676.927921308693, 5687.744051517691, 5688.345840228344, 5702.54379649627, 5188.325517682677, 5357.973210134002, 5372.7313634318125, 5395.568354531628, 5396.163594642837, 2990.624312816129, 3006.556852710711, 3012.894548690785, 3018.2001769531093, 3019.230096325423, 5881.853038657421, 5885.499732522698, 5900.468957793819, 5910.340346843852, 5940.8811823764145, 5632.943670563324, 5794.507466865363, 5796.536277097822, 5802.970985145132, 5804.767809287581, 5871.178035075179, 5879.52963762898, 5897.52819774417, 5908.734106965197, 5911.940880591225, 5382.757775900172, 5580.437477506305, 5653.915191272216, 5662.886742265214, 5676.716164191691, 5573.888522229614, 5584.329880414376, 5593.580481463988, 5610.661656314486, 5628.85927851807, 5881.441263080001, 5882.382349853204, 5888.676122813286, 5905.405540504125, 5909.2908850938165, 3855.4024126260474, 3993.5806740293015, 4067.1052368478886, 4068.715189936676, 4075.49056367954, 5604.299462567179, 5613.24221230145, 5622.269105016485, 5632.690202038927, 5648.519875810603, 5404.621676482609, 5504.174373843955, 5528.226048353315, 5547.33431988164, 5555.388907220122, 5312.707801070978, 5531.446855314436, 5565.693886836263, 5584.692841893735, 5588.748506317307, 5547.55619550443, 5553.556794787258, 5556.611037227517, 5557.638753481173, 5588.189712491585, 5309.36287645485, 5453.890922181614, 5488.1767734838495, 5573.247611572386, 5586.916196257141, 5455.7817687293655, 5456.727163641882, 5458.426865179099, 5459.344878614592, 5462.672239665632], "value": 4219.692074933726, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [735.8601865645527, 768.7616838779978, 792.6908505682785, 815.9020917489902, 828.5650033732294, 15239.999999999985, 15813.0, 16002.279897404616, 16050.919745401257, 16906.830931690678, 15268.618284542865, 15439.84560154398, 15461.845381546182, 15541.378344866192, 15597.220138993034, 650.6421468192499, 675.2538445018258, 787.7242964962261, 811.3833486550235, 816.9019717633893, 794.2176955698632, 816.2368185746346, 824.9381296402764, 825.9008918929707, 826.6197549127409, 876.9649214031431, 879.7624641346832, 880.295763389286, 880.6213328268842, 881.1364862434817, 680.6630717794674, 706.9257727938596, 876.3208513402133, 876.5617191404298, 877.0221203358242, 611.843979785152, 627.9780207692754, 633.5311869216746, 634.0995785983914, 634.2515831319041, 14969.550913472613, 14988.325525351276, 14989.850101498954, 15012.924935375362, 15027.699446011018, 13918.721625567534, 14043.578692639237, 14394.712105757932, 14489.637759056108, 14760.926195368955, 12589.0, 12714.554990575378, 12800.935995320056, 12912.418941147576, 12926.54757083507, 4225.492940847087, 4242.40606315113, 4286.525076918491, 4310.3103503439615, 4335.826566937319, 81303.18696813015, 81491.5925420375, 81617.59191204006, 82115.0, 83866.58066709628, 10829.430970614972, 11061.612843550438, 11438.828417573743, 11491.942540287246, 11746.941265293619, 20691.896540517202, 20741.58516829655, 20799.1680332785, 20949.162033518794, 21018.89490552568, 7198.208197098315, 7702.0, 7961.243681850215, 8591.742247732578, 8617.439866408664, 4487.753173575419, 4673.737549367816, 4703.0593881223895, 4834.371531700856, 4873.415190177201, 3749.8500059997295, 3845.5577608574813, 3909.4722212500947, 3910.550286717007, 3911.1395492991496, 684.4319215051495, 684.9863002740017, 692.9896051559231, 706.6219572528776, 710.4281053751677, 716.2372073741449, 732.9890051649229, 744.7170075371324, 759.1838773318705, 767.5279702982625, 9013.0, 9480.525973701426, 9750.452656833668, 10222.6422075227, 10353.896461035443, 587.7854583077146, 663.8805015097232, 670.5373292428209, 686.375398387465, 709.4749885085, 4607.815687372467, 4921.138800709861, 4979.6265280104135, 5002.59979201663, 5052.494750524992, 69233.0, 69259.0, 70378.0, 98940.0, 121896.39051804684, 99986.50006749919, 99990.0, 100058.499707501, 100112.49943750381, 100279.49860250652, 86823.56588217018, 88607.0, 89975.55012224897, 90292.5485372569, 93757.5312123435, 9158.313126515404, 9539.523023848918, 9590.472524010967, 9690.127359948812, 9785.559649815634, 52507.73746131245, 53432.73283633557, 53472.73263633657, 53718.194227087406, 54619.72690136683, 76341.0, 76714.23285767071, 77308.0, 78000.60999694966, 79074.20925790668, 12093.395330233629, 12961.351932403531, 13031.47874085026, 13160.934195328962, 13502.86497135016, 14950.102993820406, 15306.387744490095, 15394.846051539342, 15421.306041228396, 15542.5337239883, 13072.934635326763, 13222.206667599974, 13981.772030459848, 14341.92829035848, 14969.625759355667, 13756.724865502834, 14567.635809104857, 14728.26358682083, 15256.542303730906, 15308.703694445921, 13766.793498097337, 13989.510367137102, 14260.643483912985, 14262.286885655469, 14670.26648667541, 11294.289370551172, 11383.772324553629, 11530.59642912494, 11557.88442115568, 11669.649910502698, 11391.487383067617, 11862.584809531625, 12264.632061038183, 12414.81377779352, 12473.563425280072], "value": 7672.178430852876, "unit": "score"}], "name": "dromaeo_css", "value": 7196.721986991798, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 112.0, 111.0, 112.0, 111.0, 111.0, 110.0, 111.0, 112.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 125.0, 121.0, 165.0, 120.0, 124.0, 127.0, 126.0, 155.0, 120.0], "value": 133.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 159.0, 160.0, 161.0, 161.0, 162.0, 162.0, 162.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 120.0, 80.0, 76.0, 75.0, 75.0, 113.0, 75.0], "value": 83.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 119.0, 82.0, 82.0, 82.0, 119.0, 82.0, 82.0, 119.0], "value": 93.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 96.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 52.0, 51.0, 52.0, 52.0, 53.0, 53.0, 52.0, 53.0], "value": 52.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 63.0, 62.0, 61.0, 61.0, 62.0, 61.0, 62.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 79.0, 80.0, 80.0, 80.0, 79.0, 80.0, 88.0, 79.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 131.0, 139.0, 127.0, 141.0, 132.0, 137.0, 144.0, 167.0, 132.0], "value": 139.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 170.0, 165.0, 165.0, 170.0, 164.0, 170.0, 165.0, 164.0, 165.0], "value": 166.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 69.0, 68.0, 65.0, 69.0, 69.0, 70.0, 65.0, 72.0, 65.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1507.9, "alertThreshold": 2.0}]} 07:51:16 INFO - Return code: 0 07:51:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:51:16 INFO - # TBPL SUCCESS # 07:51:16 INFO - Running post-action listener: _resource_record_post_action 07:51:16 INFO - [mozharness: 2016-10-11 14:51:16.854339Z] Finished run-tests step (success) 07:51:16 INFO - Running post-run listener: _resource_record_post_run 07:51:16 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 2277376; Write bytes: 401121280; Read time: 572; Write time: 274788 07:51:16 INFO - TinderboxPrint: CPU usage
13.0% 07:51:16 INFO - TinderboxPrint: I/O read bytes / time
2,277,376 / 572 07:51:16 INFO - TinderboxPrint: I/O write bytes / time
401,121,280 / 274,788 07:51:16 INFO - TinderboxPrint: CPU idle
8,310.3 (86.9%) 07:51:16 INFO - TinderboxPrint: CPU user
1,198.2 (12.5%) 07:51:16 INFO - TinderboxPrint: Swap in / out
0 / 0 07:51:16 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 111185920; Read time: 0; Write time: 84972 07:51:16 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 2277376; Write bytes: 289935360; Read time: 572; Write time: 189816 07:51:17 INFO - Running post-run listener: _upload_blobber_files 07:51:17 INFO - Blob upload gear active. 07:51:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:51:17 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 07:51:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:51:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:51:17 INFO - (blobuploader) - INFO - Open directory for files ... 07:51:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:51:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:51:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:51:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:51:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:51:21 INFO - (blobuploader) - INFO - Done attempting. 07:51:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:51:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:51:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:51:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:51:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:51:22 INFO - (blobuploader) - INFO - Done attempting. 07:51:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:51:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:51:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:51:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:51:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:51:23 INFO - (blobuploader) - INFO - Done attempting. 07:51:23 INFO - (blobuploader) - INFO - Iteration through files over. 07:51:23 INFO - Return code: 0 07:51:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:51:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:51:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f16f196185914777ac2191a3b0824bb3e43eb07e95456ebad322558ce08f0ea1a763d5579ef36305ff5d842d4139f98deaa5b56c66f1a2ee6aa5e3dc06791fff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e014a219f80603dbe119febde2dcfcdfab5de34968c8b60e6bd751affebb30efade9cc08caf6bbfd010ec75f1323f9901d447db4d3b3df214130fd8ff2257aad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5619d88a219afd0d01ff10d6f137ff856ccd171cd869d979ace706e655a3e423ad85401c7d58df629276dff79f4450c5f42aa3a8b82eb62ca29777e905a10a48"} 07:51:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:51:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:51:23 INFO - Contents: 07:51:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f16f196185914777ac2191a3b0824bb3e43eb07e95456ebad322558ce08f0ea1a763d5579ef36305ff5d842d4139f98deaa5b56c66f1a2ee6aa5e3dc06791fff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e014a219f80603dbe119febde2dcfcdfab5de34968c8b60e6bd751affebb30efade9cc08caf6bbfd010ec75f1323f9901d447db4d3b3df214130fd8ff2257aad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5619d88a219afd0d01ff10d6f137ff856ccd171cd869d979ace706e655a3e423ad85401c7d58df629276dff79f4450c5f42aa3a8b82eb62ca29777e905a10a48"} 07:51:23 INFO - Running post-run listener: copy_logs_to_upload_dir 07:51:23 INFO - Copying logs to upload dir... 07:51:23 INFO - mkdir: /builds/slave/test/build/upload/logs 07:51:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.405349 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-10-11 07:51:22.709607) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-11 07:51:22.713571) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1476196239.261761-66575131 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f16f196185914777ac2191a3b0824bb3e43eb07e95456ebad322558ce08f0ea1a763d5579ef36305ff5d842d4139f98deaa5b56c66f1a2ee6aa5e3dc06791fff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e014a219f80603dbe119febde2dcfcdfab5de34968c8b60e6bd751affebb30efade9cc08caf6bbfd010ec75f1323f9901d447db4d3b3df214130fd8ff2257aad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5619d88a219afd0d01ff10d6f137ff856ccd171cd869d979ace706e655a3e423ad85401c7d58df629276dff79f4450c5f42aa3a8b82eb62ca29777e905a10a48"} build_url:https://queue.taskcluster.net/v1/task/Z9LOcrN6R7eCPFycCeIPMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011338 build_url: 'https://queue.taskcluster.net/v1/task/Z9LOcrN6R7eCPFycCeIPMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f16f196185914777ac2191a3b0824bb3e43eb07e95456ebad322558ce08f0ea1a763d5579ef36305ff5d842d4139f98deaa5b56c66f1a2ee6aa5e3dc06791fff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e014a219f80603dbe119febde2dcfcdfab5de34968c8b60e6bd751affebb30efade9cc08caf6bbfd010ec75f1323f9901d447db4d3b3df214130fd8ff2257aad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5619d88a219afd0d01ff10d6f137ff856ccd171cd869d979ace706e655a3e423ad85401c7d58df629276dff79f4450c5f42aa3a8b82eb62ca29777e905a10a48"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-11 07:51:22.742756) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 07:51:22.743122) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1476196239.261761-66575131 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004537 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 07:51:22.824116) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-11 07:51:22.824437) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-11 07:51:22.824718) ========= ========= Total master_lag: 0.17 =========