builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-001 starttime: 1475186719.48 results: success (0) buildid: 20160929141519 builduid: 14f2a8dc16064473b3555ee25fc915d4 revision: 7de011ec6e45a2e5019ecae87acacb8bb2a8f381 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-29 15:05:19.475592) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-29 15:05:19.476605) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-29 15:05:19.477182) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-29 15:05:19.623570) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 15:05:19.624102) ========= 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=8887e36bb8e381bfd44124ac000001a8-1475185853.26066-1079958624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-29 15:05:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.3M=0s 2016-09-29 15:05:20 (42.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113402 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 15:05:19.752961) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 15:05:19.753271) ========= 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=8887e36bb8e381bfd44124ac000001a8-1475185853.26066-1079958624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021202 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 15:05:19.809212) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-29 15:05:19.809567) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 7de011ec6e45a2e5019ecae87acacb8bb2a8f381 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 7de011ec6e45a2e5019ecae87acacb8bb2a8f381 --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=8887e36bb8e381bfd44124ac000001a8-1475185853.26066-1079958624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-29 15:05:20,239 truncating revision to first 12 chars 2016-09-29 15:05:20,239 Setting DEBUG logging. 2016-09-29 15:05:20,239 attempt 1/10 2016-09-29 15:05:20,239 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/7de011ec6e45?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-29 15:05:21,308 unpacking tar archive at: autoland-7de011ec6e45/testing/mozharness/ program finished with exit code 0 elapsedTime=1.505606 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-29 15:05:21.333100) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-29 15:05:21.333704) ========= script_repo_revision: 7de011ec6e45a2e5019ecae87acacb8bb2a8f381 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-29 15:05:21.334155) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-29 15:05:21.334514) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-29 15:05:21.346535) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-09-29 15:05:21.347373) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1475185853.26066-1079958624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:05:21 INFO - MultiFileLogger online at 20160929 15:05:21 in /builds/slave/test 15:05:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 15:05:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:05:21 INFO - {'append_to_log': False, 15:05:21 INFO - 'base_work_dir': '/builds/slave/test', 15:05:21 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 15:05:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:05:21 INFO - 'branch': 'Autoland-Non-PGO', 15:05:21 INFO - 'buildbot_json_path': 'buildprops.json', 15:05:21 INFO - 'config_files': ('talos/linux_config.py',), 15:05:21 INFO - 'default_actions': ('clobber', 15:05:21 INFO - 'read-buildbot-config', 15:05:21 INFO - 'download-and-extract', 15:05:21 INFO - 'populate-webroot', 15:05:21 INFO - 'create-virtualenv', 15:05:21 INFO - 'install', 15:05:21 INFO - 'run-tests'), 15:05:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:05:21 INFO - 'download_minidump_stackwalk': True, 15:05:21 INFO - 'download_symbols': 'ondemand', 15:05:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:05:21 INFO - 'tooltool.py': '/tools/tooltool.py', 15:05:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:05:21 INFO - '/tools/misc-python/virtualenv.py')}, 15:05:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:05:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:05:21 INFO - 'installer_path': 'installer.exe', 15:05:21 INFO - 'log_level': 'info', 15:05:21 INFO - 'log_name': 'talos', 15:05:21 INFO - 'log_to_console': True, 15:05:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:05:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:05:21 INFO - 'opt_config_files': (), 15:05:21 INFO - 'pip_index': False, 15:05:21 INFO - 'sps_profile': False, 15:05:21 INFO - 'sps_profile_interval': 0, 15:05:21 INFO - 'suite': 'dromaeojs-e10s', 15:05:21 INFO - 'system_bits': '32', 15:05:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:05:21 INFO - 'title': 'talos-linux64-ix-001', 15:05:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:05:21 INFO - 'use_talos_json': True, 15:05:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:05:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:05:21 INFO - 'work_dir': 'build'} 15:05:21 INFO - [mozharness: 2016-09-29 22:05:21.882035Z] Running clobber step. 15:05:21 INFO - Running pre-action listener: _resource_record_pre_action 15:05:21 INFO - Running main action method: clobber 15:05:21 INFO - rmtree: /builds/slave/test/build 15:05:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:05:22 INFO - Running post-action listener: _resource_record_post_action 15:05:22 INFO - [mozharness: 2016-09-29 22:05:22.867907Z] Finished clobber step (success) 15:05:22 INFO - [mozharness: 2016-09-29 22:05:22.868006Z] Running read-buildbot-config step. 15:05:22 INFO - Running pre-action listener: _resource_record_pre_action 15:05:22 INFO - Running main action method: read_buildbot_config 15:05:22 INFO - Using buildbot properties: 15:05:22 INFO - { 15:05:22 INFO - "project": "", 15:05:22 INFO - "product": "firefox", 15:05:22 INFO - "script_repo_revision": "production", 15:05:22 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 15:05:22 INFO - "repository": "", 15:05:22 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 15:05:22 INFO - "buildid": "20160929141519", 15:05:22 INFO - "pgo_build": "False", 15:05:22 INFO - "basedir": "/builds/slave/test", 15:05:22 INFO - "buildnumber": 482, 15:05:22 INFO - "slavename": "talos-linux64-ix-001", 15:05:22 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:05:22 INFO - "platform": "ubuntu64_hw", 15:05:22 INFO - "scheduler": "tests-autoland-linux64-talos-8-3600", 15:05:22 INFO - "branch": "autoland", 15:05:22 INFO - "repo_path": "integration/autoland", 15:05:22 INFO - "revision": "7de011ec6e45a2e5019ecae87acacb8bb2a8f381", 15:05:22 INFO - "stage_platform": "linux64", 15:05:22 INFO - "builduid": "14f2a8dc16064473b3555ee25fc915d4", 15:05:22 INFO - "slavebuilddir": "test" 15:05:22 INFO - } 15:05:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/OICit1p9Q2mHldHrzJlp-Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 15:05:22 INFO - Running post-action listener: _resource_record_post_action 15:05:22 INFO - [mozharness: 2016-09-29 22:05:22.870511Z] Finished read-buildbot-config step (success) 15:05:22 INFO - [mozharness: 2016-09-29 22:05:22.870599Z] Running download-and-extract step. 15:05:22 INFO - Running pre-action listener: _resource_record_pre_action 15:05:22 INFO - Running main action method: download_and_extract 15:05:22 INFO - mkdir: /builds/slave/test/build/tests 15:05:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:05:22 INFO - trying https://queue.taskcluster.net/v1/task/OICit1p9Q2mHldHrzJlp-Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:05:22 INFO - Downloading https://queue.taskcluster.net/v1/task/OICit1p9Q2mHldHrzJlp-Q/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 15:05:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OICit1p9Q2mHldHrzJlp-Q/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 15:05:23 INFO - Downloaded 1361 bytes. 15:05:23 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:05:23 INFO - Using the following test package requirements: 15:05:23 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:05:23 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:05:23 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:05:23 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:23 INFO - u'jsshell-linux-x86_64.zip'], 15:05:23 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:05:23 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:05:23 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:05:23 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:05:23 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:05:23 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:05:23 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:05:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OICit1p9Q2mHldHrzJlp-Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:05:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OICit1p9Q2mHldHrzJlp-Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:05:23 INFO - Fetch https://queue.taskcluster.net/v1/task/OICit1p9Q2mHldHrzJlp-Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:05:24 INFO - Http code: 200 15:05:24 INFO - Content-Encoding: None 15:05:24 INFO - Content-Type: application/zip 15:05:24 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 15:05:24 INFO - x-amz-cf-id: 7_1rbbeMUKkfJSlZYASeiFnC4g0kkxWlOyLbSgyTRiXUZwa9rBvsxQ== 15:05:24 INFO - x-amz-version-id: ovunQfjQq0ekyCnDtLI687MvWyefZXiu 15:05:24 INFO - x-cache: Hit from cloudfront 15:05:24 INFO - Expected file size: 20418097 15:05:24 INFO - Obtained file size: 20418097 15:05:28 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 15:05:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OICit1p9Q2mHldHrzJlp-Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:05:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OICit1p9Q2mHldHrzJlp-Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:05:28 INFO - Fetch https://queue.taskcluster.net/v1/task/OICit1p9Q2mHldHrzJlp-Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:05:28 INFO - Http code: 200 15:05:28 INFO - Content-Encoding: None 15:05:28 INFO - Content-Type: application/zip 15:05:28 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 15:05:28 INFO - x-amz-cf-id: srrUsPrxb50KXC-JSEB0f1TuThOXXr3gVOr8fsM7O8x-n4i8uekY0A== 15:05:28 INFO - x-amz-version-id: ovunQfjQq0ekyCnDtLI687MvWyefZXiu 15:05:28 INFO - x-cache: Hit from cloudfront 15:05:29 INFO - Expected file size: 20418097 15:05:29 INFO - Obtained file size: 20418097 15:05:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OICit1p9Q2mHldHrzJlp-Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 15:05:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OICit1p9Q2mHldHrzJlp-Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:05:33 INFO - Fetch https://queue.taskcluster.net/v1/task/OICit1p9Q2mHldHrzJlp-Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 15:05:34 INFO - Http code: 200 15:05:34 INFO - Content-Encoding: None 15:05:34 INFO - Content-Type: application/zip 15:05:34 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 15:05:34 INFO - x-amz-cf-id: qUaO0kpScov2HD0LUuvfoUveV1jDmGWNgJa-pnYJVid-mG7b5uhnwA== 15:05:34 INFO - x-amz-version-id: 6Lq6JfQVg8ERFj3nfdWPddeZeps9zZXT 15:05:34 INFO - x-cache: Hit from cloudfront 15:05:34 INFO - Expected file size: 14414067 15:05:34 INFO - Obtained file size: 14414067 15:05:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:05:34 INFO - trying https://queue.taskcluster.net/v1/task/OICit1p9Q2mHldHrzJlp-Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:05:34 INFO - Downloading https://queue.taskcluster.net/v1/task/OICit1p9Q2mHldHrzJlp-Q/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 15:05:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OICit1p9Q2mHldHrzJlp-Q/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 15:05:35 INFO - Downloaded 55741929 bytes. 15:05:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OICit1p9Q2mHldHrzJlp-Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:05:35 INFO - mkdir: /builds/slave/test/properties 15:05:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:05:35 INFO - Writing to file /builds/slave/test/properties/build_url 15:05:35 INFO - Contents: 15:05:35 INFO - build_url:https://queue.taskcluster.net/v1/task/OICit1p9Q2mHldHrzJlp-Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:05:36 INFO - Running post-action listener: _resource_record_post_action 15:05:36 INFO - Running post-action listener: set_extra_try_arguments 15:05:36 INFO - [mozharness: 2016-09-29 22:05:36.613526Z] Finished download-and-extract step (success) 15:05:36 INFO - [mozharness: 2016-09-29 22:05:36.613752Z] Running populate-webroot step. 15:05:36 INFO - Running pre-action listener: _resource_record_pre_action 15:05:36 INFO - Running main action method: populate_webroot 15:05:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:05:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:05:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:05:36 INFO - '--tppagecycles', 15:05:36 INFO - '7'], 15:05:36 INFO - 'tests': ['tsvgm']}}, 15:05:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:05:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:05:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:05:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:05:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:05:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:05:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:36 INFO - 'talos_options': ['--disable-e10s'], 15:05:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:05:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:05:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:36 INFO - 'talos_options': ['--disable-e10s'], 15:05:36 INFO - 'tests': ['damp', 'tps']}, 15:05:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:36 INFO - 'tests': ['damp', 'tps']}, 15:05:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:05:36 INFO - 'tests': ['dromaeo_dom']}, 15:05:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:05:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:05:36 INFO - 'tests': ['basic_compositor_video']}, 15:05:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:05:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:05:36 INFO - 'tests': ['a11yr', 15:05:36 INFO - 'ts_paint', 15:05:36 INFO - 'tpaint', 15:05:36 INFO - 'sessionrestore', 15:05:36 INFO - 'sessionrestore_no_auto_restore', 15:05:36 INFO - 'tabpaint']}, 15:05:36 INFO - 'other-e10s': {'tests': ['a11yr', 15:05:36 INFO - 'ts_paint', 15:05:36 INFO - 'tpaint', 15:05:36 INFO - 'sessionrestore', 15:05:36 INFO - 'sessionrestore_no_auto_restore', 15:05:36 INFO - 'tabpaint']}, 15:05:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:05:36 INFO - 'ts_paint', 15:05:36 INFO - 'tpaint', 15:05:36 INFO - 'sessionrestore', 15:05:36 INFO - 'sessionrestore_no_auto_restore', 15:05:36 INFO - 'tabpaint']}, 15:05:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:05:36 INFO - 'ts_paint', 15:05:36 INFO - 'tpaint', 15:05:36 INFO - 'sessionrestore', 15:05:36 INFO - 'sessionrestore_no_auto_restore', 15:05:36 INFO - 'tabpaint']}, 15:05:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:05:36 INFO - 'tests': ['a11yr', 15:05:36 INFO - 'ts_paint', 15:05:36 INFO - 'tpaint', 15:05:36 INFO - 'sessionrestore', 15:05:36 INFO - 'sessionrestore_no_auto_restore', 15:05:36 INFO - 'tabpaint']}, 15:05:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:05:36 INFO - 'tests': ['a11yr', 15:05:36 INFO - 'ts_paint', 15:05:36 INFO - 'tpaint', 15:05:36 INFO - 'sessionrestore', 15:05:36 INFO - 'sessionrestore_no_auto_restore', 15:05:36 INFO - 'tabpaint']}, 15:05:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:05:36 INFO - 'tests': ['tsvgx', 15:05:36 INFO - 'tsvgr_opacity', 15:05:36 INFO - 'tart', 15:05:36 INFO - 'tscrollx', 15:05:36 INFO - 'cart']}, 15:05:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:05:36 INFO - 'tsvgr_opacity', 15:05:36 INFO - 'tart', 15:05:36 INFO - 'tscrollx', 15:05:36 INFO - 'cart']}, 15:05:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:36 INFO - 'talos_options': ['--disable-e10s'], 15:05:36 INFO - 'tests': ['tp5o']}, 15:05:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:36 INFO - 'tests': ['tp5o']}, 15:05:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:36 INFO - 'talos_options': ['--disable-e10s', 15:05:36 INFO - '--xperf_path', 15:05:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:05:36 INFO - 'tests': ['tp5n']}, 15:05:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:36 INFO - 'talos_options': ['--xperf_path', 15:05:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:05:36 INFO - 'tests': ['tp5n']}}, 15:05:36 INFO - 'talos.zip': {'path': '', 15:05:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:05:36 INFO - Running post-action listener: _resource_record_post_action 15:05:36 INFO - [mozharness: 2016-09-29 22:05:36.634002Z] Finished populate-webroot step (success) 15:05:36 INFO - [mozharness: 2016-09-29 22:05:36.634090Z] Running create-virtualenv step. 15:05:36 INFO - Running pre-action listener: _resource_record_pre_action 15:05:36 INFO - Running main action method: create_virtualenv 15:05:36 INFO - Creating virtualenv /builds/slave/test/build/venv 15:05:36 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:05:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:05:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:05:36 INFO - Using real prefix '/usr' 15:05:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:05:37 INFO - Installing distribute.............................................................................................................................................................................................done. 15:05:39 INFO - Installing pip.................done. 15:05:39 INFO - Return code: 0 15:05:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:05:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:05:39 INFO - Reading from file tmpfile_stdout 15:05:39 INFO - Output received: 15:05:39 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 15:05:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:05:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:05:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:05:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:39 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 0x7f72d5d50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf55ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf52f60>, '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 0xf53d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf541d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1475185853.26066-1079958624', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:05:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:05:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:05:39 INFO - Using env: {'DISPLAY': ':0', 15:05:39 INFO - 'HOME': '/home/cltbld', 15:05:39 INFO - 'LANG': 'en_US.UTF-8', 15:05:39 INFO - 'LANGUAGE': 'en_US:en', 15:05:39 INFO - 'LOGNAME': 'cltbld', 15:05:39 INFO - 'MAIL': '/var/mail/cltbld', 15:05:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:39 INFO - 'MOZ_NO_REMOTE': '1', 15:05:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:39 INFO - 'NO_EM_RESTART': '1', 15:05:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:39 INFO - 'PWD': '/builds/slave/test', 15:05:39 INFO - 'SHELL': '/bin/bash', 15:05:39 INFO - 'SHLVL': '1', 15:05:39 INFO - 'TERM': 'linux', 15:05:39 INFO - 'TMOUT': '86400', 15:05:39 INFO - 'USER': 'cltbld', 15:05:39 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475185853.26066-1079958624', 15:05:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:39 INFO - '_': '/tools/buildbot/bin/python'} 15:05:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:05:39 INFO - Cleaning up... 15:05:39 INFO - Return code: 0 15:05:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:05:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:05:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:05:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:39 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 0x7f72d5d50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf55ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf52f60>, '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 0xf53d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf541d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1475185853.26066-1079958624', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:05:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:05:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:05:39 INFO - Using env: {'DISPLAY': ':0', 15:05:39 INFO - 'HOME': '/home/cltbld', 15:05:39 INFO - 'LANG': 'en_US.UTF-8', 15:05:39 INFO - 'LANGUAGE': 'en_US:en', 15:05:39 INFO - 'LOGNAME': 'cltbld', 15:05:39 INFO - 'MAIL': '/var/mail/cltbld', 15:05:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:39 INFO - 'MOZ_NO_REMOTE': '1', 15:05:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:39 INFO - 'NO_EM_RESTART': '1', 15:05:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:39 INFO - 'PWD': '/builds/slave/test', 15:05:39 INFO - 'SHELL': '/bin/bash', 15:05:39 INFO - 'SHLVL': '1', 15:05:39 INFO - 'TERM': 'linux', 15:05:39 INFO - 'TMOUT': '86400', 15:05:39 INFO - 'USER': 'cltbld', 15:05:39 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475185853.26066-1079958624', 15:05:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:39 INFO - '_': '/tools/buildbot/bin/python'} 15:05:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:39 INFO - Downloading/unpacking psutil>=3.1.1 15:05:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:05:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:05:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:05:41 INFO - Installing collected packages: psutil 15:05:41 INFO - Running setup.py install for psutil 15:05:41 INFO - building 'psutil._psutil_linux' extension 15:05:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:05:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:05:42 INFO - building 'psutil._psutil_posix' extension 15:05:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:05:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:05:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:05:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:05:42 INFO - Successfully installed psutil 15:05:42 INFO - Cleaning up... 15:05:42 INFO - Return code: 0 15:05:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:05: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')]} 15:05:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05: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')]} 15:05:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:42 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 0x7f72d5d50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf55ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf52f60>, '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 0xf53d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf541d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1475185853.26066-1079958624', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:05:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:05:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:05:42 INFO - Using env: {'DISPLAY': ':0', 15:05:42 INFO - 'HOME': '/home/cltbld', 15:05:42 INFO - 'LANG': 'en_US.UTF-8', 15:05:42 INFO - 'LANGUAGE': 'en_US:en', 15:05:42 INFO - 'LOGNAME': 'cltbld', 15:05:42 INFO - 'MAIL': '/var/mail/cltbld', 15:05:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:42 INFO - 'MOZ_NO_REMOTE': '1', 15:05:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:42 INFO - 'NO_EM_RESTART': '1', 15:05:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:42 INFO - 'PWD': '/builds/slave/test', 15:05:42 INFO - 'SHELL': '/bin/bash', 15:05:42 INFO - 'SHLVL': '1', 15:05:42 INFO - 'TERM': 'linux', 15:05:42 INFO - 'TMOUT': '86400', 15:05:42 INFO - 'USER': 'cltbld', 15:05:42 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475185853.26066-1079958624', 15:05:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:42 INFO - '_': '/tools/buildbot/bin/python'} 15:05:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:05:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:05:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:05:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:05:44 INFO - Installing collected packages: mozsystemmonitor 15:05:44 INFO - Running setup.py install for mozsystemmonitor 15:05:44 INFO - Successfully installed mozsystemmonitor 15:05:44 INFO - Cleaning up... 15:05:44 INFO - Return code: 0 15:05:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:05:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f72d5d50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf55ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf52f60>, '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 0xf53d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf541d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1475185853.26066-1079958624', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:05:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:05:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:05:44 INFO - Using env: {'DISPLAY': ':0', 15:05:44 INFO - 'HOME': '/home/cltbld', 15:05:44 INFO - 'LANG': 'en_US.UTF-8', 15:05:44 INFO - 'LANGUAGE': 'en_US:en', 15:05:44 INFO - 'LOGNAME': 'cltbld', 15:05:44 INFO - 'MAIL': '/var/mail/cltbld', 15:05:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:44 INFO - 'MOZ_NO_REMOTE': '1', 15:05:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:44 INFO - 'NO_EM_RESTART': '1', 15:05:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:44 INFO - 'PWD': '/builds/slave/test', 15:05:44 INFO - 'SHELL': '/bin/bash', 15:05:44 INFO - 'SHLVL': '1', 15:05:44 INFO - 'TERM': 'linux', 15:05:44 INFO - 'TMOUT': '86400', 15:05:44 INFO - 'USER': 'cltbld', 15:05:44 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475185853.26066-1079958624', 15:05:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:44 INFO - '_': '/tools/buildbot/bin/python'} 15:05:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:44 INFO - Downloading/unpacking jsonschema==2.5.1 15:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:05:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:46 INFO - Downloading functools32-3.2.3-2.tar.gz 15:05:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:05:47 INFO - warning: no files found matching '*.txt' 15:05:47 INFO - no previously-included directories found matching 'build' 15:05:47 INFO - no previously-included directories found matching 'dist' 15:05:47 INFO - no previously-included directories found matching '.git*' 15:05:47 INFO - Installing collected packages: jsonschema, functools32 15:05:47 INFO - Running setup.py install for functools32 15:05:47 INFO - warning: no files found matching '*.txt' 15:05:47 INFO - no previously-included directories found matching 'build' 15:05:47 INFO - no previously-included directories found matching 'dist' 15:05:47 INFO - no previously-included directories found matching '.git*' 15:05:47 INFO - Successfully installed jsonschema functools32 15:05:47 INFO - Cleaning up... 15:05:47 INFO - Return code: 0 15:05:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:05:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:05:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:47 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 0x7f72d5d50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf55ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf52f60>, '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 0xf53d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf541d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1475185853.26066-1079958624', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:05:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:05:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:05:47 INFO - Using env: {'DISPLAY': ':0', 15:05:47 INFO - 'HOME': '/home/cltbld', 15:05:47 INFO - 'LANG': 'en_US.UTF-8', 15:05:47 INFO - 'LANGUAGE': 'en_US:en', 15:05:47 INFO - 'LOGNAME': 'cltbld', 15:05:47 INFO - 'MAIL': '/var/mail/cltbld', 15:05:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:47 INFO - 'MOZ_NO_REMOTE': '1', 15:05:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:47 INFO - 'NO_EM_RESTART': '1', 15:05:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:47 INFO - 'PWD': '/builds/slave/test', 15:05:47 INFO - 'SHELL': '/bin/bash', 15:05:47 INFO - 'SHLVL': '1', 15:05:47 INFO - 'TERM': 'linux', 15:05:47 INFO - 'TMOUT': '86400', 15:05:47 INFO - 'USER': 'cltbld', 15:05:47 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475185853.26066-1079958624', 15:05:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:47 INFO - '_': '/tools/buildbot/bin/python'} 15:05:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:05:47 INFO - Cleaning up... 15:05:47 INFO - Return code: 0 15:05:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:05:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:05:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:47 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 0x7f72d5d50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf55ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf52f60>, '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 0xf53d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf541d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1475185853.26066-1079958624', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:05:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:05:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:05:47 INFO - Using env: {'DISPLAY': ':0', 15:05:47 INFO - 'HOME': '/home/cltbld', 15:05:47 INFO - 'LANG': 'en_US.UTF-8', 15:05:47 INFO - 'LANGUAGE': 'en_US:en', 15:05:47 INFO - 'LOGNAME': 'cltbld', 15:05:47 INFO - 'MAIL': '/var/mail/cltbld', 15:05:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:47 INFO - 'MOZ_NO_REMOTE': '1', 15:05:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:47 INFO - 'NO_EM_RESTART': '1', 15:05:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:47 INFO - 'PWD': '/builds/slave/test', 15:05:47 INFO - 'SHELL': '/bin/bash', 15:05:47 INFO - 'SHLVL': '1', 15:05:47 INFO - 'TERM': 'linux', 15:05:47 INFO - 'TMOUT': '86400', 15:05:47 INFO - 'USER': 'cltbld', 15:05:47 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475185853.26066-1079958624', 15:05:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:47 INFO - '_': '/tools/buildbot/bin/python'} 15:05:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:47 INFO - Downloading/unpacking blobuploader==1.2.4 15:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:49 INFO - Downloading blobuploader-1.2.4.tar.gz 15:05:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:05:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:05:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:05:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:50 INFO - Downloading docopt-0.6.1.tar.gz 15:05:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:05:50 INFO - Installing collected packages: blobuploader, requests, docopt 15:05:50 INFO - Running setup.py install for blobuploader 15:05:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:05:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:05:50 INFO - Running setup.py install for requests 15:05:50 INFO - Running setup.py install for docopt 15:05:50 INFO - Successfully installed blobuploader requests docopt 15:05:50 INFO - Cleaning up... 15:05:51 INFO - Return code: 0 15:05:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:05:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:05:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:51 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 0x7f72d5d50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf55ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf52f60>, '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 0xf53d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf541d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1475185853.26066-1079958624', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:05:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:05:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:05:51 INFO - Using env: {'DISPLAY': ':0', 15:05:51 INFO - 'HOME': '/home/cltbld', 15:05:51 INFO - 'LANG': 'en_US.UTF-8', 15:05:51 INFO - 'LANGUAGE': 'en_US:en', 15:05:51 INFO - 'LOGNAME': 'cltbld', 15:05:51 INFO - 'MAIL': '/var/mail/cltbld', 15:05:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:51 INFO - 'MOZ_NO_REMOTE': '1', 15:05:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:51 INFO - 'NO_EM_RESTART': '1', 15:05:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:51 INFO - 'PWD': '/builds/slave/test', 15:05:51 INFO - 'SHELL': '/bin/bash', 15:05:51 INFO - 'SHLVL': '1', 15:05:51 INFO - 'TERM': 'linux', 15:05:51 INFO - 'TMOUT': '86400', 15:05:51 INFO - 'USER': 'cltbld', 15:05:51 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475185853.26066-1079958624', 15:05:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:51 INFO - '_': '/tools/buildbot/bin/python'} 15:05:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:05:51 INFO - Running setup.py (path:/tmp/pip-N9LkvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:05:51 INFO - Running setup.py (path:/tmp/pip-KQRLyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:05:51 INFO - Running setup.py (path:/tmp/pip-DPTctS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:05:51 INFO - Running setup.py (path:/tmp/pip-IENlDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:05:51 INFO - Running setup.py (path:/tmp/pip-HE5FBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:05:51 INFO - Running setup.py (path:/tmp/pip-QAeqNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:05:51 INFO - Running setup.py (path:/tmp/pip-mc8MuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:05:51 INFO - Running setup.py (path:/tmp/pip-tYWZ6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:05:51 INFO - Running setup.py (path:/tmp/pip-_4DKS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:05:51 INFO - Running setup.py (path:/tmp/pip-doDE7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:05:51 INFO - Running setup.py (path:/tmp/pip-sUd8kQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:05:52 INFO - Running setup.py (path:/tmp/pip-H99hkA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:05:52 INFO - Running setup.py (path:/tmp/pip-ps8Ptv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:05:52 INFO - Running setup.py (path:/tmp/pip-vOmBnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:05:52 INFO - Running setup.py (path:/tmp/pip-IEfrIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:05:52 INFO - Running setup.py (path:/tmp/pip-FEsWer-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:05:52 INFO - Running setup.py (path:/tmp/pip-ySAOUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:05:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:05:52 INFO - Running setup.py install for manifestparser 15:05:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:05:52 INFO - Running setup.py install for mozcrash 15:05:52 INFO - Running setup.py install for mozdebug 15:05:52 INFO - Running setup.py install for mozdevice 15:05:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:05:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:05:52 INFO - Running setup.py install for mozfile 15:05:53 INFO - Running setup.py install for mozhttpd 15:05:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:05:53 INFO - Running setup.py install for mozinfo 15:05:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:05:53 INFO - Running setup.py install for mozInstall 15:05:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:05:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:05:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:05:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:05:53 INFO - Running setup.py install for mozleak 15:05:53 INFO - Running setup.py install for mozlog 15:05:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:05:53 INFO - Running setup.py install for moznetwork 15:05:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:05:53 INFO - Running setup.py install for mozprocess 15:05:53 INFO - Running setup.py install for mozprofile 15:05:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:05:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:05:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:05:53 INFO - Running setup.py install for mozrunner 15:05:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:05:53 INFO - Running setup.py install for mozscreenshot 15:05:54 INFO - Running setup.py install for moztest 15:05:54 INFO - Running setup.py install for mozversion 15:05:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:05:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:05:54 INFO - Cleaning up... 15:05:54 INFO - Return code: 0 15:05:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:05: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')]} 15:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05: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')]} 15:05:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:54 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 0x7f72d5d50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf55ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf52f60>, '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 0xf53d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf541d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1475185853.26066-1079958624', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:05:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:05:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:05:54 INFO - Using env: {'DISPLAY': ':0', 15:05:54 INFO - 'HOME': '/home/cltbld', 15:05:54 INFO - 'LANG': 'en_US.UTF-8', 15:05:54 INFO - 'LANGUAGE': 'en_US:en', 15:05:54 INFO - 'LOGNAME': 'cltbld', 15:05:54 INFO - 'MAIL': '/var/mail/cltbld', 15:05:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:54 INFO - 'MOZ_NO_REMOTE': '1', 15:05:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:54 INFO - 'NO_EM_RESTART': '1', 15:05:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:54 INFO - 'PWD': '/builds/slave/test', 15:05:54 INFO - 'SHELL': '/bin/bash', 15:05:54 INFO - 'SHLVL': '1', 15:05:54 INFO - 'TERM': 'linux', 15:05:54 INFO - 'TMOUT': '86400', 15:05:54 INFO - 'USER': 'cltbld', 15:05:54 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475185853.26066-1079958624', 15:05:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:54 INFO - '_': '/tools/buildbot/bin/python'} 15:05:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:05:54 INFO - Running setup.py (path:/tmp/pip-Xz7oQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:05:54 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:05:54 INFO - Running setup.py (path:/tmp/pip-u8UTHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:05:54 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)) 15:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:05:54 INFO - Running setup.py (path:/tmp/pip-mb4Oba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:05:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:05:54 INFO - Running setup.py (path:/tmp/pip-8vltyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:05:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:05:54 INFO - Running setup.py (path:/tmp/pip-2hFG4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:05:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:05:54 INFO - Running setup.py (path:/tmp/pip-nB0AIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:05:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:05:54 INFO - Running setup.py (path:/tmp/pip-5teccY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:05:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:05:55 INFO - Running setup.py (path:/tmp/pip-5Hk60K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:05:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:05:55 INFO - Running setup.py (path:/tmp/pip-PZfLTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:05:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:05:55 INFO - Running setup.py (path:/tmp/pip-7qqoSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:05:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:05:55 INFO - Running setup.py (path:/tmp/pip-ll_DNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:05:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:05:55 INFO - Running setup.py (path:/tmp/pip-YscyK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:05:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:05:55 INFO - Running setup.py (path:/tmp/pip-IVdqY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:05:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:05:55 INFO - Running setup.py (path:/tmp/pip-767lMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:05:55 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)) 15:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:05:55 INFO - Running setup.py (path:/tmp/pip-bPXyF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:05:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:05:55 INFO - Running setup.py (path:/tmp/pip-ytblMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:05:55 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)) 15:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:05:55 INFO - Running setup.py (path:/tmp/pip-rA4CED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:05:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:05:55 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)) 15:05:55 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)) 15:05:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:05:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:05:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:05:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:57 INFO - Downloading blessings-1.6.tar.gz 15:05:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:05:57 INFO - Installing collected packages: blessings 15:05:57 INFO - Running setup.py install for blessings 15:05:57 INFO - Successfully installed blessings 15:05:57 INFO - Cleaning up... 15:05:57 INFO - Return code: 0 15:05:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:05:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:05:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:05:58 INFO - Reading from file tmpfile_stdout 15:05:58 INFO - Current package versions: 15:05:58 INFO - argparse == 1.2.1 15:05:58 INFO - blessings == 1.6 15:05:58 INFO - blobuploader == 1.2.4 15:05:58 INFO - docopt == 0.6.1 15:05:58 INFO - functools32 == 3.2.3-2 15:05:58 INFO - jsonschema == 2.5.1 15:05:58 INFO - manifestparser == 1.1 15:05:58 INFO - mozInstall == 1.12 15:05:58 INFO - mozcrash == 0.17 15:05:58 INFO - mozdebug == 0.1 15:05:58 INFO - mozdevice == 0.48 15:05:58 INFO - mozfile == 1.2 15:05:58 INFO - mozhttpd == 0.7 15:05:58 INFO - mozinfo == 0.9 15:05:58 INFO - mozleak == 0.1 15:05:58 INFO - mozlog == 3.4 15:05:58 INFO - moznetwork == 0.27 15:05:58 INFO - mozprocess == 0.23 15:05:58 INFO - mozprofile == 0.28 15:05:58 INFO - mozrunner == 6.12 15:05:58 INFO - mozscreenshot == 0.1 15:05:58 INFO - mozsystemmonitor == 0.3 15:05:58 INFO - moztest == 0.7 15:05:58 INFO - mozversion == 1.4 15:05:58 INFO - psutil == 3.1.1 15:05:58 INFO - requests == 1.2.3 15:05:58 INFO - wsgiref == 0.1.2 15:05:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:05:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:58 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 0x7f72d5d50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf55ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf52f60>, '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 0xf53d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf541d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1475185853.26066-1079958624', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:05:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:05:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:05:58 INFO - Using env: {'DISPLAY': ':0', 15:05:58 INFO - 'HOME': '/home/cltbld', 15:05:58 INFO - 'LANG': 'en_US.UTF-8', 15:05:58 INFO - 'LANGUAGE': 'en_US:en', 15:05:58 INFO - 'LOGNAME': 'cltbld', 15:05:58 INFO - 'MAIL': '/var/mail/cltbld', 15:05:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:58 INFO - 'MOZ_NO_REMOTE': '1', 15:05:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:58 INFO - 'NO_EM_RESTART': '1', 15:05:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:58 INFO - 'PWD': '/builds/slave/test', 15:05:58 INFO - 'SHELL': '/bin/bash', 15:05:58 INFO - 'SHLVL': '1', 15:05:58 INFO - 'TERM': 'linux', 15:05:58 INFO - 'TMOUT': '86400', 15:05:58 INFO - 'USER': 'cltbld', 15:05:58 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475185853.26066-1079958624', 15:05:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:58 INFO - '_': '/tools/buildbot/bin/python'} 15:05:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:05:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:05:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:05:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:05:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:05:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:05:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:05:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:05:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:05:58 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:05:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:05:58 INFO - Cleaning up... 15:05:58 INFO - Return code: 0 15:05:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:05:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:58 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 0x7f72d5d50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf55ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf52f60>, '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 0xf53d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf541d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1475185853.26066-1079958624', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:05:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:05:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:05:58 INFO - Using env: {'DISPLAY': ':0', 15:05:58 INFO - 'HOME': '/home/cltbld', 15:05:58 INFO - 'LANG': 'en_US.UTF-8', 15:05:58 INFO - 'LANGUAGE': 'en_US:en', 15:05:58 INFO - 'LOGNAME': 'cltbld', 15:05:58 INFO - 'MAIL': '/var/mail/cltbld', 15:05:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:58 INFO - 'MOZ_NO_REMOTE': '1', 15:05:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:58 INFO - 'NO_EM_RESTART': '1', 15:05:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:58 INFO - 'PWD': '/builds/slave/test', 15:05:58 INFO - 'SHELL': '/bin/bash', 15:05:58 INFO - 'SHLVL': '1', 15:05:58 INFO - 'TERM': 'linux', 15:05:58 INFO - 'TMOUT': '86400', 15:05:58 INFO - 'USER': 'cltbld', 15:05:58 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475185853.26066-1079958624', 15:05:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:58 INFO - '_': '/tools/buildbot/bin/python'} 15:05:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:05:58 INFO - Cleaning up... 15:05:58 INFO - Return code: 0 15:05:58 INFO - Running post-action listener: _resource_record_post_action 15:05:58 INFO - Running post-action listener: _start_resource_monitoring 15:05:58 INFO - Starting resource monitoring. 15:05:58 INFO - [mozharness: 2016-09-29 22:05:58.587702Z] Finished create-virtualenv step (success) 15:05:58 INFO - [mozharness: 2016-09-29 22:05:58.588212Z] Running install step. 15:05:58 INFO - Running pre-action listener: _resource_record_pre_action 15:05:58 INFO - Running main action method: install 15:05:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:05:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:05:58 INFO - Reading from file tmpfile_stdout 15:05:58 INFO - Detecting whether we're running mozinstall >=1.0... 15:05:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:05:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:05:58 INFO - Reading from file tmpfile_stdout 15:05:58 INFO - Output received: 15:05:58 INFO - Usage: mozinstall [options] installer 15:05:58 INFO - Options: 15:05:58 INFO - -h, --help show this help message and exit 15:05:58 INFO - -d DEST, --destination=DEST 15:05:58 INFO - Directory to install application into. [default: 15:05:58 INFO - "/builds/slave/test"] 15:05:58 INFO - --app=APP Application being installed. [default: firefox] 15:05:58 INFO - mkdir: /builds/slave/test/build/application 15:05:58 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'] 15:05:58 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 15:06:14 INFO - Reading from file tmpfile_stdout 15:06:14 INFO - Output received: 15:06:14 INFO - /builds/slave/test/build/application/firefox/firefox 15:06:14 INFO - Running post-action listener: _resource_record_post_action 15:06:14 INFO - [mozharness: 2016-09-29 22:06:14.989570Z] Finished install step (success) 15:06:14 INFO - [mozharness: 2016-09-29 22:06:14.989816Z] Running run-tests step. 15:06:14 INFO - Running pre-action listener: _resource_record_pre_action 15:06:14 INFO - Running main action method: run_tests 15:06:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:06:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:06:14 INFO - Python 2.7.3 15:06:14 INFO - Return code: 0 15:06:14 INFO - grabbing minidump binary from tooltool 15:06: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')]} 15:06:14 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 0xf52f60>, '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 0xf53d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf541d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:06:14 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:06:14 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:06:14 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:06:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:06:15 INFO - Return code: 0 15:06:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:06:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:06:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:06:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:06:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:06:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OICit1p9Q2mHldHrzJlp-Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:06:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OICit1p9Q2mHldHrzJlp-Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:06:15 INFO - Using env: {'DISPLAY': ':0', 15:06:15 INFO - 'HOME': '/home/cltbld', 15:06:15 INFO - 'LANG': 'en_US.UTF-8', 15:06:15 INFO - 'LANGUAGE': 'en_US:en', 15:06:15 INFO - 'LOGNAME': 'cltbld', 15:06:15 INFO - 'MAIL': '/var/mail/cltbld', 15:06:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:06:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:06:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:15 INFO - 'MOZ_NO_REMOTE': '1', 15:06:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:06:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:15 INFO - 'NO_EM_RESTART': '1', 15:06:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:15 INFO - 'PWD': '/builds/slave/test', 15:06:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:06:15 INFO - 'SHELL': '/bin/bash', 15:06:15 INFO - 'SHLVL': '1', 15:06:15 INFO - 'TERM': 'linux', 15:06:15 INFO - 'TMOUT': '86400', 15:06:15 INFO - 'USER': 'cltbld', 15:06:15 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475185853.26066-1079958624', 15:06:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:15 INFO - '_': '/tools/buildbot/bin/python'} 15:06:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OICit1p9Q2mHldHrzJlp-Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:06:15 INFO - mozversion application_buildid: 20160929141519 15:06:15 INFO - mozversion application_changeset: 7de011ec6e45a2e5019ecae87acacb8bb2a8f381 15:06:15 INFO - mozversion application_display_name: Nightly 15:06:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:06:15 INFO - mozversion application_name: Firefox 15:06:15 INFO - mozversion application_remotingname: firefox 15:06:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 15:06:15 INFO - mozversion application_vendor: Mozilla 15:06:15 INFO - mozversion application_version: 52.0a1 15:06:15 INFO - mozversion platform_buildid: 20160929141519 15:06:15 INFO - mozversion platform_changeset: 7de011ec6e45a2e5019ecae87acacb8bb2a8f381 15:06:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 15:06:15 INFO - mozversion platform_version: 52.0a1 15:06:15 INFO - using testdate: 1475186775 15:06:15 INFO - actual date: 1475186775 15:06:15 INFO - starting webserver on 'localhost:47317' 15:06:15 INFO - SUITE-START | Running 2 tests 15:06:15 INFO - TEST-START | dromaeo_css 15:06:15 INFO - operating with platform_type : linux_ 15:06:15 INFO - Initialising browser for dromaeo_css test... 15:06:15 INFO - TEST-INFO | started process 31974 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjgllOr/profile http://localhost:47317/getInfo.html) 15:06:20 INFO - PROCESS | 31974 | __metrics Screen width/height:1600/1200 15:06:20 INFO - PROCESS | 31974 | colorDepth:24 15:06:20 INFO - PROCESS | 31974 | Browser inner width/height: 1024/697 15:06:20 INFO - PROCESS | 31974 | __metrics 15:06:20 ERROR - PROCESS | 31974 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3076: TypeError: this.tabs is undefined 15:06:21 INFO - TEST-INFO | 31974: exit 0 15:06:21 INFO - Browser initialized. 15:06:21 INFO - Running cycle 1/1 for dromaeo_css test... 15:06:21 INFO - TEST-INFO | started process 32094 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjgllOr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:06:34 INFO - PROCESS | 32094 | RSS: Main: 186273792 15:06:34 INFO - PROCESS | 32094 | 15:07:23 INFO - PROCESS | 32094 | 1475186843945 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] 15:09:36 INFO - PROCESS | 32094 | Cycle 1(1): loaded http://localhost:47317/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47317/tests/dromaeo/cssquery-ext.html) 15:09:37 INFO - PROCESS | 32094 | RSS: Main: 200220672 15:09:37 INFO - PROCESS | 32094 | 15:12:40 INFO - PROCESS | 32094 | Cycle 1(1): loaded http://localhost:47317/tests/dromaeo/cssquery-ext.html (next: http://localhost:47317/tests/dromaeo/cssquery-jquery.html) 15:12:40 INFO - PROCESS | 32094 | RSS: Main: 196808704 15:12:40 INFO - PROCESS | 32094 | 15:15:42 INFO - PROCESS | 32094 | Cycle 1(1): loaded http://localhost:47317/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47317/tests/dromaeo/cssquery-mootools.html) 15:15:43 INFO - PROCESS | 32094 | RSS: Main: 197836800 15:15:43 INFO - PROCESS | 32094 | 15:18:45 INFO - PROCESS | 32094 | Cycle 1(1): loaded http://localhost:47317/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47317/tests/dromaeo/cssquery-prototype.html) 15:18:46 INFO - PROCESS | 32094 | RSS: Main: 194682880 15:18:46 INFO - PROCESS | 32094 | 15:21:48 INFO - PROCESS | 32094 | Cycle 1(1): loaded http://localhost:47317/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47317/tests/dromaeo/cssquery-yui.html) 15:21:49 INFO - PROCESS | 32094 | RSS: Main: 198520832 15:21:49 INFO - PROCESS | 32094 | 15:24:52 INFO - PROCESS | 32094 | Cycle 1(1): loaded http://localhost:47317/tests/dromaeo/cssquery-yui.html (next: http://localhost:47317/tests/dromaeo/cssquery-dojo.html) 15:24:52 INFO - PROCESS | 32094 | RSS: Main: 198676480 15:24:52 INFO - PROCESS | 32094 | 15:24:52 INFO - PROCESS | 32094 | __start_tp_report 15:24:52 INFO - PROCESS | 32094 | _x_x_mozilla_page_load 15:24:52 INFO - PROCESS | 32094 | _x_x_mozilla_page_load_details 15:24:52 INFO - PROCESS | 32094 | |i|pagename|runs| 15:24:52 INFO - PROCESS | 32094 | |0;dojo.html;2586.9094581689637;2602.245348848834;2611.099170786078;2626.973730262697;2651.2974061873606;4510.143072816162;4664.137134630096;4686.648501362399;4702.24764037754;4723.07899959508;4628.90742185157;4662;4688.554587314208;4706.858794236178;4742.051589682069;4249.957500424987;4292.570742925714;4322.697411181219;4371.235033869076;4430.490493593245;4335.284678028122;4364.192624364487;4367.301231802912;4369.279068953619;4415.139047885664;4187.120704652027;4238.978805105986;4291.721038132543;4313.590208930146;4389.978050109729;4313.1158112586845;4353.673474489426;4359.542248063939;4414.690971631987;4418.955810441887;4298.097399546099;4329.9134017319475;4347.543507931685;4357.150355680644;4393.209222339978;4568.109218702354;4592.035672508777;4723.740194289313;4741.336212930192;4803.423589169322;5009.849704508871;5066.771995260222;5072.695638261716;5077.26379674945;5144.871378215537;5110.540051395392;5111.849610634378;5119.820806271762;5122.897542049175;5171.4311425743135;4608.9308660370125;4765.26138448541;4770;4774.594159496447;4825.372701548777;5061.291419201315;5098.1842905135;5154.072266991902;5159.174532074925;5227.817026404134;4964.304997300381;4966.230234313687;4977.0792403405485;4982.078315511642;5027.874303142451;4796.352492413549;4872.049950259736;5033.974830125826;5062.721550314768;5064.518870707277;5039.143345631178;5052.747362631853;5068.037072956126;5111.258867464271;5129.743512824344;5026.346574945307;5042.798288068436;5046.949530504721;5052.368453943257;5112.284280200774;4239.59723826236;4305.117450922553;4360.520342762294;4362.890927726832;4420.823167073346;3756.323861704919;3782.3002744492355;3784.9432258516144;3828.464015037897;3882.4176373544196;4416.3596278539435;4418.756968366771;4434.955650443454;4436.733795972252;4466.883279180205;4916.311716359713;5068.746562671851;5094.083065048327;5125.15434953236;5134.897302053938;4289.420928174656;4351.19502891966;4379.934300985424;4412.624926881251;4451.5103338632725;4580.26715725489;4595.586397224199;4597.7011494252765;4602.861914142581;4660.5106463821485;4794.5924596409695;4804.975975120102;4805.087033463631;4807.927881081787;4864.051509955525;4917.237828136645;4968.105740966661;5003.824866129668;5055.848324550269;5064.113780088396;4715.764211789466;4721.22099853534;4726.031163611383;4770.189067858541;4774;4898.755062246944;4906.582940450102;4906.705597664151;4921.212605983025;4971.502849715;4918.286848407032;4968;4987.6508644396;5007.273945277987;5025.020121076355;4907.411110666742;4917.360743103373;4918.2376731606655;4968.975155124346;4978.352814134139;4681.391419115494;4854.63590230727;4856.077345304381;4905.23968784839;4968.900621987467;4648.976755116203;4655.068986202706;4720.5043470436485;4828.203346447796;4885.926711099408;4919.508049195052;4925;4934.333864928189;4946.826861059845;5011.824586139468;4824.95175048245;4836.298736683231;4836.492168322276;4844.903101938012;4909.631777616764 15:24:52 INFO - PROCESS | 32094 | |1;ext.html;548.1722598875698;556.5519756595941;558.012318196792;564.2016546586581;568.2328856044338;38317.616823831755;40282.39576406353;40292.798536007314;43393;43409;39996.200075998466;40445.595544044554;40498.59501404985;40701.59298407015;40713;7605.619719014041;7719.073711154641;7734.419918506106;7736.34241089508;7750.14748377678;7673.961630191841;7760.146383897767;7762.107357653886;7780.766577002699;7783.688652453923;7761.068671759369;7796.844063118734;7809.297163255306;7812.960935195316;7828.725994590191;7702.961485192566;7728.574928378937;7769.456138070337;7789.649465774054;7794.922050779476;7660;7709;7735.110462296795;7739.883901741478;7749.186335434754;37345.25309493795;37451.81274093612;37481.43777843335;37601.24797504034;37623.435648465296;2862.685104638488;2897.377063931244;3197.344544368399;3607.837647305851;3650;28197.85901070502;28325.57511637327;28746.568801467994;30765.692343076505;31494.842525787226;3144.921376965571;3204.214967333018;3250.9837450812593;3276.8689252429876;3278.2623909620384;247681;248001.9999999982;248306;248573;249466;53529;53592.83682376576;53640.73179634077;53668.19497707538;53859.19211211835;31881.202969925474;32486.187845304055;32543;34686.47970280448;34883.12792180216;12892.355382230851;12907.161034532724;12920.806187907188;12923.483060677467;12949;10206.438645874548;10239.18086553074;10270.845937310947;10276.126529244948;10311.9484402579;17487.825121748872;17614.383496577557;17645.470635880945;17647.294108235783;17737.822621773874;6715.597064176165;6781.830454238585;7007.754728584475;7010.263922288188;7050.541714788523;762.897008903802;810.9716159934374;918.875951746519;928.6331898899897;990.5641517732175;25736.613950790754;28028;28058.71941280561;28241;28419.152755070852;942.2320808541017;949.6154057606681;992.5235886774244;1044.9164066874632;1094.2996482251365;14066.507672231422;14984.850151498564;14990.400383984737;15206.239688015556;15219.543413697607;397555;401393;402004;402668;403563;48537.757311213216;48932;49003;49118.75440622846;49307;1128.1257025805066;1155.8439610652622;1159.5072094359864;1163.8836116388463;1197.9401029948642;26127.869360653076;26947.326316842235;27587.586186207624;27789.30526736767;27891.302717432227;41214.79392603138;41344.586554134075;41348.793256033525;41378.1724365505;41481.1703765917;302780;304623;306080;306246;307872;24620.6306905393;25014;25274;25296.367590810376;25308;40150;41076.79461602673;41883.581164189185;41913.37129942992;42158.1568368637;35599.64400355963;35852.82073589615;36029.63970360263;36375.634264003165;36697.44953825748;35826.820865895505;35835;36004.639953600126;36380;36922.26155476929;30830;31486.055418337488;34703.826480867436;35241.82379088191;36087.45868811917;27665;31935.520967185046;32194.35611287808;32718.672813272515;32774.1806454831;24577.877110614332;24734.752652473246;24898.377540561632;25210.873945630887;25349.873250633627 15:24:52 INFO - PROCESS | 32094 | |2;jquery.html;351.54299410766;366.6260414377334;372.2443439817171;377.2059814091339;392.2958289869684;15248.695026099485;16327.428540001103;16612.91693541532;16746.413875514358;16813.579660508494;13779.931100344484;14857.479988200415;14964.700705985873;14988.175650339253;15024.399024039052;4661.860144195671;5046.899062018758;5073.0107629012355;5077.720725360104;5079.517445842639;3705.499757532739;3848.730588858781;5015.648904576663;5716.971415142919;6020.789272375468;6044.063170208603;6074.362191969846;6084.5436592255755;6087.2086628738425;6093.390660933894;5817.214676018725;6012.8496787580225;6043.0331147016705;6043.425874541911;6044.153818465418;4590.839320623795;5283.973580132113;5300.469953004707;5302.0721373759825;5304.840854774363;12082.637520874388;14429.989900706954;18257.360992365335;19883.30408435698;19884.304049358205;1729.2996336483743;1839.6964500857343;2142.06820033286;2238.541099074686;2281.498070424504;8685.435446696009;8720.52037137957;9064.229540489066;9065.637374505011;9446.763830904214;1652.9090900000494;1722.1389305347327;1729.437932671874;1731.4892106828515;1771.1498480729194;64703;66215.3378466214;68740.65629671869;69324.6533767328;70261;9363.063693630582;9441.339106262496;9492.382995105296;9671.613135474643;9720.854187187198;12911.870881291256;12946.287954162422;12957.611271661677;12984.091113621957;13034.543790967271;6647.202335719745;6868.656567171622;6973.860522789516;7029.0862187915245;7054.470914681317;6452.870942581216;6547.869042619121;6574.441172500391;6721.529492935448;6724.831879203059;4010.979945100256;4059;4090.570490098497;4155.317096575892;4156.521999969982;1431.6420894776306;1528.3580896023698;1555.587769241152;1851.8703690741788;1854.9258029678663;788.113372455987;819.9180081991753;869.2741560796806;875.7066382761719;885.3890815337396;15468.149251791034;15646.2176891155;16415.26131324093;16457.835421645632;17057.402990895258;796.9960150199328;838.4256784102909;847.174339298812;857.0972441180569;878.7539488943106;8970.282377409922;9059.320550958704;9548.278740558908;9609.837786497981;9613.807723845484;351785;353303;355712;365570;383014;74307.62846185734;75475.24524754792;75693;76213.61893190499;76438.23561764423;911.3483859040817;927.3971918253189;953.7901661634429;954.9734035911423;955.4458414119794;13825.239611821446;14841.554753357417;14932.925335373253;15085.094894306376;15482.690346193238;35040.47439288362;35924.82037589795;36403.63596364002;36857;37140.44289335716;47364.52635473739;48891;49177.50822491729;50451;50929.490705092474;6996.860062798613;7274.927250727636;7300.050993370828;7475.813104672427;7597.3162415382885;9767.609295628095;11475.655730328104;11565.363904985306;11706.531738730697;11974.58088966882;4891.926621100615;4989.151844186425;8830.42602230853;9657.22742180638;10174.186065114922;9126.589303481493;9935.801283974135;10017.198624110199;10180.490975451346;10318.43248621333;9180.632774689206;10064;10206.693799186036;10250.846237306298;10382.584696612052;7256.2743725629125;7320.560766354036;7336.816579585553;7407.851842963219;7559.659815308434;6912.983321928146;9281.257499399897;9357.953210234178;9532.66635667776;9535.618575256913 15:24:52 INFO - PROCESS | 32094 | |3;mootools.html;1326.661701266177;1381.43361221899;1429.8427173010973;1658.8424099710523;1663.667266546691;6267.968660156705;6519.90220146697;7021.22766495685;7591.962040189798;7607.961960190199;7068.2931706829295;7336.926630733691;7341.192468828424;7535.698572057111;7541.170471248159;2101.831853451724;2123.2568600989684;2126.25581046634;2126.606577783115;2133.2746866065536;2048.3138148720195;2067.2454554087726;2068.782777808331;2072.9481762955897;2093.602215579043;2051.640962831506;2062.927797527087;2069.430906500717;2071.337172104927;2073.512724509739;2038.9898050509726;2048.3138148720195;2048.9077991490417;2052.558699879518;2056.7737548869613;1995.0523501336893;2000.779914209436;2006.2877678424095;2014.244658253155;2017.213286818142;7224.494285400024;7329.926700732978;7330.926690733131;7331.853362932765;7343;4155.335146376596;4259.403683484315;4272.081502476983;4289.420928174719;4289.442372491588;2735.7948153888537;2750.821196622213;2812.3812761192503;2874.195225336909;2891.7252860978174;873.7335112790596;886.3263919421222;908.5593487158723;932.7761337279072;937.1144268666113;9793.951030244874;9800.90199098007;9900.702978910644;9918.553665085088;9919.404835709809;3791.374423220193;3843.8462461501786;4027.8993025174605;4035.071933455322;4040.5353384361174;8337.333013359039;8356.70751523706;8359.623816928253;8360.205780450848;8363.540005299767;4402.757848318373;4455.220336441174;4455.287154055401;4457.4205353304515;4470.687051906335;3434.4504879219203;3561.6794488495643;3924.6075392460525;4066.8169932352525;4091.1408604193452;3402.1834759657504;3447.1554469154717;3609.873654422135;3624.0758606555687;3640.0899775056237;1126.3393969598803;1143.1826244235413;1146.489812033637;1199.1126566340845;1200.8198770184542;791.6160662078887;794.8450052239758;797.8643630582815;814.3770015937812;820.6143112737004;4881.902361952741;4983.476734942778;5047.343845300161;5095.490450954875;5096.439391666913;383.8963479860422;390.0463367067549;390.3715018819698;392.24297106584567;393.4531001907351;3384.966150338514;3389.796612203276;3391.542141810873;3397.8301084945656;3489.616142224353;8754.518501482353;9003;9073.45559266446;9076.455412675261;9092.499912504876;8918.955405222932;8934.151255630704;8941.37410381267;8946.239569636524;8951.283897288331;6952.826179345557;6956.130483689539;6994.2656021117045;7008.404285635676;7034.331738484836;4797.832075877328;4863.610911127172;4871.415430148405;4927.704337739604;5019.598432125495;8100.554469504234;8240.83518329642;8325.916740832514;8355;8374.916250837658;8373;8408.2432581068;8408.747737567883;8440.324774017941;8468.247819458576;5581.49766521015;5758.107493338539;6272;6299.30707622152;6398.71205795731;6786.898196526958;7017.929820701932;7055.506114571931;7240.167380751281;7260.092488438945;6464.870702586016;6481.578697384655;6510.348965103642;6672.933270667231;6680.164979377578;6224.910640637961;6266.874662506633;6270.874582508415;6290.1508296381235;6316.494680425463;5665.291838520185;5759.8560035999435;5804.158397032322;5816.505597024131;5817;4160.417541544247;4230.492340918986;4261.488621365332;4303.203907277164;4394.560543945579;4281.892952676208;4336.761478118734;4375.081232941118;4384.583464570861;4499.550044995474 15:24:52 INFO - PROCESS | 32094 | |4;prototype.html;278.94839454700883;286.32427471168046;288.97688184945207;289.4197134744836;298.3317369093231;4792.8497160681445;4911.084676975982;4915.926261106082;5001.749912504374;5019.849404517861;4745.833895813647;4813.518648135185;4857.587105096062;4870.902581948359;4891.510848915107;3831.252905683393;3874.9806250968845;3880.6313400227073;3888.51393575803;3907.8241479133508;3639.909002274938;3873.612638736132;3890.6692931100893;3903.9609603904023;3904.472896159025;3778.619469734064;3796.1838204785968;3804.744434336676;3807.409851473012;3845.288621605012;3791.49761157636;3792.317382871096;3812.8093595320124;3818.1981783825154;3828.6937045036607;3314.850831712579;3330.5670262865915;3339.866405343808;3340.2150494633743;3341.6992470677756;4707.905841883177;4764.2615394613895;4784.64115191362;4820.276958456225;4847.351900353861;4319.436464916425;4342.891427714301;4344.608985191317;4345.69580129391;4354.738715677038;5150.510701483353;5151.381834179922;5169.896602067975;5177.948220517785;5188.5849132069725;3411.9488207676904;3613;3616.4032934565766;3635.4910312556262;3640.8179591020344;5301.118103073392;5383.75773090208;5385.976664433745;5386.111291636876;5389.649672771257;3675.044488432973;3683.4290684943876;3686.7419280650633;3693;3697.685696715809;3719.1631882826146;3720.1815600567834;3724.510195921653;3729.533808273966;3731.2910546996527;4186.162767446523;4236.915261694749;4279.272523670983;4280.850170244026;4293.141371725667;5174.896502069938;5182.948170518246;5185.507376799198;5189.40321862983;5201.505856943584;1190.4404929683035;1214.7488087270126;1263.829383033297;1266.5693664154232;1289.4584274604688;857.1642648417743;866.5927014303268;884.7390019944132;886.8182022685334;891.3760367742606;4566.383538222364;4583.816647334069;4584.9312260315455;4586.4266966629175;4586.701864378805;5300.429291793477;5320.388155362183;5325.254464374913;5328.547073498718;5332.10710197882;4578.9771051144535;4582.518835522289;4586.610138138229;4590.42619672541;4590.816367345269;2707.7156898525764;2837.90067347646;2840.7358725367426;2851.4867323881485;2854.6146270253666;5036.395632524121;5053.646244762905;5056.595472362203;5064.442911279756;5086.135356989321;5289.312389389354;5491.2312276281355;5491.341039075336;5496.258005169331;5501.889962200814;5018.8920653325695;5042.856785866065;5055.797768089235;5059.241113832954;5063.569596584258;5360.571154307568;5363.436839131835;5368.469986053956;5373.731313434235;5379.973100134631;5049.192129259301;5244.7902083916215;5245.763940622604;5253.50091741284;5258.395284542326;5020.472850350807;5031.798728050983;5052.46949070357;5056.924146137737;5073.6702114363925;3632.3643362410944;3647.8723244686307;3663.487111804296;3663.9816800915823;3668.3396988541253;5141.460146684693;5331.733413329395;5333.919991200212;5365.678059316453;5407.729613519387;5272.630915836008;5276.707206734374;5281;5286.20706893969;5297.682139071668;5262.789488420421;5279.128943724242;5306;5327.440618735132;5344.786208551614;5038.129890843871;5062.645614806928;5131.076406246762;5187.213334265932;5203.635745497779;5245.895082098413;5259.658122222043;5272.815451459181;5274.578033757213;5280.5445467857635;5175.792968281377;5180.637355385237;5199.272101905812;5201.193814958688;5202.1416466282635 15:24:52 INFO - PROCESS | 32094 | |5;yui.html;603.7102190948344;642.9067785171151;714.0610097721494;722.7181399254292;737.9372753315968;12505.937470312647;12711.618651440449;13000.73998520029;13031.739365212701;13103.868961310383;12720.745585088293;13029.804552931713;13071.73856522869;13092.214467131978;13121.212727236372;633.1104797759156;734.8493558820443;765.7434759355623;776.6854423958306;776.8407476467311;644.7292137302321;748.5920173505452;772.1622040086513;776.409928454376;778.1906816910434;814.0394334685069;818.8689809630431;819.1808191808192;819.5001049359886;820.0118856777568;801.8075661841175;801.9278264956124;814.0760237130839;814.1817473439186;814.352589691194;584.6141546579237;585.0288521055028;587.1984740828781;591.1516973143509;592.1561774471404;12190.08574356918;12200.633980980585;12210.145289829716;12274.202176858566;12275.324857132855;13095.345232738326;13459.259740714257;13720;13857.722845543032;13982;10377.221708371902;10379.858215596278;10435.79128417435;10528.684139475752;10558.472076396149;3305.1076209423322;3329.433996220648;3337.6161741399806;3375.578052743407;3383.7462190335577;62461;63119.684401577695;63178.68410657963;64361.67819160874;65335.3466465334;8942.195202431682;9801.509924503745;9850.261230407748;10102.242331824995;10278.074973252444;16856.241469133918;17169.7424538632;17170.742438863428;17189.914050429918;17200.31198752061;6402;6647.734090636417;6721.6975236114495;7058.752943646948;7200.891986620205;3538.327717733622;3568.3220188164164;3582.982085089558;3667.8716244931297;3887.727859049896;2777.972220277771;2856.0860524632335;2869.0818937940076;2876.6260386150084;2877.6690680571583;498.5961371289267;498.6110833549837;501.5786739139141;519.4000928927095;526.147640821871;473.39405560882125;571.9942800572024;572.5591294703139;579.9275090613673;587.3539106982371;7348.225284398307;7576.886346704804;7899.526028438312;8025.117237103914;8146.67413303473;488.274911756042;501.5811797149348;505.1513457391544;507.69015938878346;588.4733163818358;4075.5924407559005;4260.2176253727885;4333.479982402132;4384.868453946387;4449.866504004885;90062.54968725114;92386;94359;97405;97851;63808.68095659585;66390;77434.61282693663;78341.60829195932;81633.18366816256;43616.563834361885;57620.42379576234;66514.66742666352;66936.330636693;67524.3247567518;8617.439866408664;8926.776830579287;9050.547472626211;9059.954700226457;9132.908670913206;42311.3653295207;42434.60523158078;42951.355729664705;43438;44974.55025449704;47239.055218896116;54112.45887541232;54403;54516.727416362664;61817.38182618116;11035.779284414106;11053.557857685602;11124.499397526968;11141.387223702774;11522.596709115141;12995.545155919497;13098.738025239632;13401.66495837612;13478.52825151115;13814.102083364549;11857.433546387472;11907.940460297643;12272.570460033856;12786.232826030468;12882.420291086735;11899.940500297444;11949.880501195224;12573.1198816082;12607.747845043232;12615.558455454015;12090.335031573348;12238.388080595756;12609.621711348675;12756.48974041028;12874.098813083368;9857.211423085993;10080.798384032425;10132.544035518567;10287.331323463952;10987.725306867393;9806.75483112928;10613.09788667972;10711.464426778786;10726.463676816284;10764.246502745045 15:24:52 INFO - PROCESS | 32094 | __end_tp_report 15:24:52 INFO - PROCESS | 32094 | __start_cc_report 15:24:52 INFO - PROCESS | 32094 | _x_x_mozilla_cycle_collect,332 15:24:52 INFO - PROCESS | 32094 | __end_cc_report 15:24:52 INFO - PROCESS | 32094 | __startTimestamp1475187892912__endTimestamp 15:24:52 INFO - PROCESS | 32094 | 15:24:52 INFO - PROCESS | 32094 | ------- Summary: start ------- 15:24:52 INFO - PROCESS | 32094 | Number of tests: 6 15:24:52 INFO - PROCESS | 32094 | 15:24:52 INFO - PROCESS | 32094 | [#0] dojo.html Cycles:165 Average:4665.31 Median:4794.59 stddev:482.70 (10.1%) stddev-sans-first:455.81 15:24:52 INFO - PROCESS | 32094 | Values: 2586.9 2602.2 2611.1 2627.0 2651.3 4510.1 4664.1 4686.6 4702.2 4723.1 4628.9 4662.0 4688.6 4706.9 4742.1 4250.0 4292.6 4322.7 4371.2 4430.5 4335.3 4364.2 4367.3 4369.3 4415.1 4187.1 4239.0 4291.7 4313.6 4390.0 4313.1 4353.7 4359.5 4414.7 4419.0 4298.1 4329.9 4347.5 4357.2 4393.2 4568.1 4592.0 4723.7 4741.3 4803.4 5009.8 5066.8 5072.7 5077.3 5144.9 5110.5 5111.8 5119.8 5122.9 5171.4 4608.9 4765.3 4770.0 4774.6 4825.4 5061.3 5098.2 5154.1 5159.2 5227.8 4964.3 4966.2 4977.1 4982.1 5027.9 4796.4 4872.0 5034.0 5062.7 5064.5 5039.1 5052.7 5068.0 5111.3 5129.7 5026.3 5042.8 5046.9 5052.4 5112.3 4239.6 4305.1 4360.5 4362.9 4420.8 3756.3 3782.3 3784.9 3828.5 3882.4 4416.4 4418.8 4435.0 4436.7 4466.9 4916.3 5068.7 5094.1 5125.2 5134.9 4289.4 4351.2 4379.9 4412.6 4451.5 4580.3 4595.6 4597.7 4602.9 4660.5 4794.6 4805.0 4805.1 4807.9 4864.1 4917.2 4968.1 5003.8 5055.8 5064.1 4715.8 4721.2 4726.0 4770.2 4774.0 4898.8 4906.6 4906.7 4921.2 4971.5 4918.3 4968.0 4987.7 5007.3 5025.0 4907.4 4917.4 4918.2 4969.0 4978.4 4681.4 4854.6 4856.1 4905.2 4968.9 4649.0 4655.1 4720.5 4828.2 4885.9 4919.5 4925.0 4934.3 4946.8 5011.8 4825.0 4836.3 4836.5 4844.9 4909.6 15:24:52 INFO - PROCESS | 32094 | 15:24:52 INFO - PROCESS | 32094 | [#1] ext.html Cycles:180 Average:46571.94 Median:19847.65 stddev:85587.38 (431.2%) stddev-sans-first:85757.72 15:24:52 INFO - PROCESS | 32094 | Values: 548.2 556.6 558.0 564.2 568.2 38317.6 40282.4 40292.8 43393.0 43409.0 39996.2 40445.6 40498.6 40701.6 40713.0 7605.6 7719.1 7734.4 7736.3 7750.1 7674.0 7760.1 7762.1 7780.8 7783.7 7761.1 7796.8 7809.3 7813.0 7828.7 7703.0 7728.6 7769.5 7789.6 7794.9 7660.0 7709.0 7735.1 7739.9 7749.2 37345.3 37451.8 37481.4 37601.2 37623.4 2862.7 2897.4 3197.3 3607.8 3650.0 28197.9 28325.6 28746.6 30765.7 31494.8 3144.9 3204.2 3251.0 3276.9 3278.3 247681.0 248002.0 248306.0 248573.0 249466.0 53529.0 53592.8 53640.7 53668.2 53859.2 31881.2 32486.2 32543.0 34686.5 34883.1 12892.4 12907.2 12920.8 12923.5 12949.0 10206.4 10239.2 10270.8 10276.1 10311.9 17487.8 17614.4 17645.5 17647.3 17737.8 6715.6 6781.8 7007.8 7010.3 7050.5 762.9 811.0 918.9 928.6 990.6 25736.6 28028.0 28058.7 28241.0 28419.2 942.2 949.6 992.5 1044.9 1094.3 14066.5 14984.9 14990.4 15206.2 15219.5 397555.0 401393.0 402004.0 402668.0 403563.0 48537.8 48932.0 49003.0 49118.8 49307.0 1128.1 1155.8 1159.5 1163.9 1197.9 26127.9 26947.3 27587.6 27789.3 27891.3 41214.8 41344.6 41348.8 41378.2 41481.2 302780.0 304623.0 306080.0 306246.0 307872.0 24620.6 25014.0 25274.0 25296.4 25308.0 40150.0 41076.8 41883.6 41913.4 42158.2 35599.6 35852.8 36029.6 36375.6 36697.4 35826.8 35835.0 36004.6 36380.0 36922.3 30830.0 31486.1 34703.8 35241.8 36087.5 27665.0 31935.5 32194.4 32718.7 32774.2 24577.9 24734.8 24898.4 25210.9 25349.9 15:24:52 INFO - PROCESS | 32094 | 15:24:52 INFO - PROCESS | 32094 | [#2] jquery.html Cycles:180 Average:22959.56 Median:5078.62 stddev:59966.59 (1180.8%) stddev-sans-first:60110.78 15:24:52 INFO - PROCESS | 32094 | Values: 351.5 366.6 372.2 377.2 392.3 15248.7 16327.4 16612.9 16746.4 16813.6 13779.9 14857.5 14964.7 14988.2 15024.4 4661.9 5046.9 5073.0 5077.7 5079.5 3705.5 3848.7 5015.6 5717.0 6020.8 6044.1 6074.4 6084.5 6087.2 6093.4 5817.2 6012.8 6043.0 6043.4 6044.2 4590.8 5284.0 5300.5 5302.1 5304.8 12082.6 14430.0 18257.4 19883.3 19884.3 1729.3 1839.7 2142.1 2238.5 2281.5 8685.4 8720.5 9064.2 9065.6 9446.8 1652.9 1722.1 1729.4 1731.5 1771.1 64703.0 66215.3 68740.7 69324.7 70261.0 9363.1 9441.3 9492.4 9671.6 9720.9 12911.9 12946.3 12957.6 12984.1 13034.5 6647.2 6868.7 6973.9 7029.1 7054.5 6452.9 6547.9 6574.4 6721.5 6724.8 4011.0 4059.0 4090.6 4155.3 4156.5 1431.6 1528.4 1555.6 1851.9 1854.9 788.1 819.9 869.3 875.7 885.4 15468.1 15646.2 16415.3 16457.8 17057.4 797.0 838.4 847.2 857.1 878.8 8970.3 9059.3 9548.3 9609.8 9613.8 351785.0 353303.0 355712.0 365570.0 383014.0 74307.6 75475.2 75693.0 76213.6 76438.2 911.3 927.4 953.8 955.0 955.4 13825.2 14841.6 14932.9 15085.1 15482.7 35040.5 35924.8 36403.6 36857.0 37140.4 47364.5 48891.0 49177.5 50451.0 50929.5 6996.9 7274.9 7300.1 7475.8 7597.3 9767.6 11475.7 11565.4 11706.5 11974.6 4891.9 4989.2 8830.4 9657.2 10174.2 9126.6 9935.8 10017.2 10180.5 10318.4 9180.6 10064.0 10206.7 10250.8 10382.6 7256.3 7320.6 7336.8 7407.9 7559.7 6913.0 9281.3 9358.0 9532.7 9535.6 15:24:52 INFO - PROCESS | 32094 | 15:24:52 INFO - PROCESS | 32094 | [#3] mootools.html Cycles:180 Average:4809.35 Median:5001.54 stddev:2677.99 (53.5%) stddev-sans-first:2672.72 15:24:52 INFO - PROCESS | 32094 | Values: 1326.7 1381.4 1429.8 1658.8 1663.7 6268.0 6519.9 7021.2 7592.0 7608.0 7068.3 7336.9 7341.2 7535.7 7541.2 2101.8 2123.3 2126.3 2126.6 2133.3 2048.3 2067.2 2068.8 2072.9 2093.6 2051.6 2062.9 2069.4 2071.3 2073.5 2039.0 2048.3 2048.9 2052.6 2056.8 1995.1 2000.8 2006.3 2014.2 2017.2 7224.5 7329.9 7330.9 7331.9 7343.0 4155.3 4259.4 4272.1 4289.4 4289.4 2735.8 2750.8 2812.4 2874.2 2891.7 873.7 886.3 908.6 932.8 937.1 9794.0 9800.9 9900.7 9918.6 9919.4 3791.4 3843.8 4027.9 4035.1 4040.5 8337.3 8356.7 8359.6 8360.2 8363.5 4402.8 4455.2 4455.3 4457.4 4470.7 3434.5 3561.7 3924.6 4066.8 4091.1 3402.2 3447.2 3609.9 3624.1 3640.1 1126.3 1143.2 1146.5 1199.1 1200.8 791.6 794.8 797.9 814.4 820.6 4881.9 4983.5 5047.3 5095.5 5096.4 383.9 390.0 390.4 392.2 393.5 3385.0 3389.8 3391.5 3397.8 3489.6 8754.5 9003.0 9073.5 9076.5 9092.5 8919.0 8934.2 8941.4 8946.2 8951.3 6952.8 6956.1 6994.3 7008.4 7034.3 4797.8 4863.6 4871.4 4927.7 5019.6 8100.6 8240.8 8325.9 8355.0 8374.9 8373.0 8408.2 8408.7 8440.3 8468.2 5581.5 5758.1 6272.0 6299.3 6398.7 6786.9 7017.9 7055.5 7240.2 7260.1 6464.9 6481.6 6510.3 6672.9 6680.2 6224.9 6266.9 6270.9 6290.2 6316.5 5665.3 5759.9 5804.2 5816.5 5817.0 4160.4 4230.5 4261.5 4303.2 4394.6 4281.9 4336.8 4375.1 4384.6 4499.6 15:24:52 INFO - PROCESS | 32094 | 15:24:52 INFO - PROCESS | 32094 | [#4] prototype.html Cycles:180 Average:4293.90 Median:4901.30 stddev:1273.57 (26.0%) stddev-sans-first:1240.97 15:24:52 INFO - PROCESS | 32094 | Values: 278.9 286.3 289.0 289.4 298.3 4792.8 4911.1 4915.9 5001.7 5019.8 4745.8 4813.5 4857.6 4870.9 4891.5 3831.3 3875.0 3880.6 3888.5 3907.8 3639.9 3873.6 3890.7 3904.0 3904.5 3778.6 3796.2 3804.7 3807.4 3845.3 3791.5 3792.3 3812.8 3818.2 3828.7 3314.9 3330.6 3339.9 3340.2 3341.7 4707.9 4764.3 4784.6 4820.3 4847.4 4319.4 4342.9 4344.6 4345.7 4354.7 5150.5 5151.4 5169.9 5177.9 5188.6 3411.9 3613.0 3616.4 3635.5 3640.8 5301.1 5383.8 5386.0 5386.1 5389.6 3675.0 3683.4 3686.7 3693.0 3697.7 3719.2 3720.2 3724.5 3729.5 3731.3 4186.2 4236.9 4279.3 4280.9 4293.1 5174.9 5182.9 5185.5 5189.4 5201.5 1190.4 1214.7 1263.8 1266.6 1289.5 857.2 866.6 884.7 886.8 891.4 4566.4 4583.8 4584.9 4586.4 4586.7 5300.4 5320.4 5325.3 5328.5 5332.1 4579.0 4582.5 4586.6 4590.4 4590.8 2707.7 2837.9 2840.7 2851.5 2854.6 5036.4 5053.6 5056.6 5064.4 5086.1 5289.3 5491.2 5491.3 5496.3 5501.9 5018.9 5042.9 5055.8 5059.2 5063.6 5360.6 5363.4 5368.5 5373.7 5380.0 5049.2 5244.8 5245.8 5253.5 5258.4 5020.5 5031.8 5052.5 5056.9 5073.7 3632.4 3647.9 3663.5 3664.0 3668.3 5141.5 5331.7 5333.9 5365.7 5407.7 5272.6 5276.7 5281.0 5286.2 5297.7 5262.8 5279.1 5306.0 5327.4 5344.8 5038.1 5062.6 5131.1 5187.2 5203.6 5245.9 5259.7 5272.8 5274.6 5280.5 5175.8 5180.6 5199.3 5201.2 5202.1 15:24:52 INFO - PROCESS | 32094 | 15:24:52 INFO - PROCESS | 32094 | [#5] yui.html Cycles:180 Average:16805.39 Median:46106.80 stddev:23188.61 (50.3%) stddev-sans-first:23221.74 15:24:52 INFO - PROCESS | 32094 | Values: 603.7 642.9 714.1 722.7 737.9 12505.9 12711.6 13000.7 13031.7 13103.9 12720.7 13029.8 13071.7 13092.2 13121.2 633.1 734.8 765.7 776.7 776.8 644.7 748.6 772.2 776.4 778.2 814.0 818.9 819.2 819.5 820.0 801.8 801.9 814.1 814.2 814.4 584.6 585.0 587.2 591.2 592.2 12190.1 12200.6 12210.1 12274.2 12275.3 13095.3 13459.3 13720.0 13857.7 13982.0 10377.2 10379.9 10435.8 10528.7 10558.5 3305.1 3329.4 3337.6 3375.6 3383.7 62461.0 63119.7 63178.7 64361.7 65335.3 8942.2 9801.5 9850.3 10102.2 10278.1 16856.2 17169.7 17170.7 17189.9 17200.3 6402.0 6647.7 6721.7 7058.8 7200.9 3538.3 3568.3 3583.0 3667.9 3887.7 2778.0 2856.1 2869.1 2876.6 2877.7 498.6 498.6 501.6 519.4 526.1 473.4 572.0 572.6 579.9 587.4 7348.2 7576.9 7899.5 8025.1 8146.7 488.3 501.6 505.2 507.7 588.5 4075.6 4260.2 4333.5 4384.9 4449.9 90062.5 92386.0 94359.0 97405.0 97851.0 63808.7 66390.0 77434.6 78341.6 81633.2 43616.6 57620.4 66514.7 66936.3 67524.3 8617.4 8926.8 9050.5 9060.0 9132.9 42311.4 42434.6 42951.4 43438.0 44974.6 47239.1 54112.5 54403.0 54516.7 61817.4 11035.8 11053.6 11124.5 11141.4 11522.6 12995.5 13098.7 13401.7 13478.5 13814.1 11857.4 11907.9 12272.6 12786.2 12882.4 11899.9 11949.9 12573.1 12607.7 12615.6 12090.3 12238.4 12609.6 12756.5 12874.1 9857.2 10080.8 10132.5 10287.3 10987.7 9806.8 10613.1 10711.5 10726.5 10764.2 15:24:52 INFO - PROCESS | 32094 | -------- Summary: end -------- 15:24:52 INFO - PROCESS | 32094 | 15:24:53 INFO - TEST-INFO | 32094: exit 0 15:24:53 INFO - TEST-OK | dromaeo_css | took 1118691ms 15:24:53 INFO - TEST-START | kraken 15:24:53 INFO - operating with platform_type : linux_ 15:24:53 INFO - Initialising browser for kraken test... 15:24:53 INFO - TEST-INFO | started process 32448 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJIHuaE/profile http://localhost:47317/getInfo.html) 15:24:58 INFO - PROCESS | 32448 | __metrics Screen width/height:1600/1200 15:24:58 INFO - PROCESS | 32448 | colorDepth:24 15:24:58 INFO - PROCESS | 32448 | Browser inner width/height: 1024/697 15:24:58 INFO - PROCESS | 32448 | __metrics 15:24:59 ERROR - PROCESS | 32448 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3076: TypeError: this.tabs is undefined 15:25:00 INFO - TEST-INFO | 32448: exit 0 15:25:00 INFO - Browser initialized. 15:25:00 INFO - Running cycle 1/1 for kraken test... 15:25:00 INFO - TEST-INFO | started process 32568 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJIHuaE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:25:12 INFO - PROCESS | 32568 | RSS: Main: 186679296 15:25:12 INFO - PROCESS | 32568 | 15:25:15 INFO - PROCESS | 32568 | Cycle 1(1): loaded http://localhost:47317/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47317/tests/kraken/driver.html?testName=audio-beat-detection) 15:25:16 INFO - PROCESS | 32568 | RSS: Main: 200007680 15:25:16 INFO - PROCESS | 32568 | 15:25:19 INFO - PROCESS | 32568 | Cycle 1(1): loaded http://localhost:47317/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47317/tests/kraken/driver.html?testName=audio-dft) 15:25:20 INFO - PROCESS | 32568 | RSS: Main: 198889472 15:25:20 INFO - PROCESS | 32568 | 15:25:23 INFO - PROCESS | 32568 | Cycle 1(1): loaded http://localhost:47317/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47317/tests/kraken/driver.html?testName=audio-fft) 15:25:23 INFO - PROCESS | 32568 | RSS: Main: 194093056 15:25:23 INFO - PROCESS | 32568 | 15:25:26 INFO - PROCESS | 32568 | Cycle 1(1): loaded http://localhost:47317/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47317/tests/kraken/driver.html?testName=audio-oscillator) 15:25:26 INFO - PROCESS | 32568 | RSS: Main: 194535424 15:25:26 INFO - PROCESS | 32568 | 15:25:28 INFO - PROCESS | 32568 | Cycle 1(1): loaded http://localhost:47317/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47317/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:25:29 INFO - PROCESS | 32568 | RSS: Main: 195272704 15:25:29 INFO - PROCESS | 32568 | 15:25:32 INFO - PROCESS | 32568 | Cycle 1(1): loaded http://localhost:47317/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47317/tests/kraken/driver.html?testName=imaging-darkroom) 15:25:33 INFO - PROCESS | 32568 | RSS: Main: 195227648 15:25:33 INFO - PROCESS | 32568 | 15:25:36 INFO - PROCESS | 32568 | Cycle 1(1): loaded http://localhost:47317/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47317/tests/kraken/driver.html?testName=imaging-desaturate) 15:25:37 INFO - PROCESS | 32568 | RSS: Main: 192655360 15:25:37 INFO - PROCESS | 32568 | 15:25:40 INFO - PROCESS | 32568 | Cycle 1(1): loaded http://localhost:47317/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47317/tests/kraken/driver.html?testName=json-parse-financial) 15:25:41 INFO - PROCESS | 32568 | RSS: Main: 194265088 15:25:41 INFO - PROCESS | 32568 | 15:25:42 INFO - PROCESS | 32568 | Cycle 1(1): loaded http://localhost:47317/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47317/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:25:43 INFO - PROCESS | 32568 | RSS: Main: 194228224 15:25:43 INFO - PROCESS | 32568 | 15:25:45 INFO - PROCESS | 32568 | Cycle 1(1): loaded http://localhost:47317/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47317/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:25:46 INFO - PROCESS | 32568 | RSS: Main: 194154496 15:25:46 INFO - PROCESS | 32568 | 15:25:48 INFO - PROCESS | 32568 | Cycle 1(1): loaded http://localhost:47317/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47317/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:25:49 INFO - PROCESS | 32568 | RSS: Main: 194658304 15:25:49 INFO - PROCESS | 32568 | 15:25:51 INFO - PROCESS | 32568 | Cycle 1(1): loaded http://localhost:47317/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47317/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:25:52 INFO - PROCESS | 32568 | RSS: Main: 194990080 15:25:52 INFO - PROCESS | 32568 | 15:25:55 INFO - PROCESS | 32568 | Cycle 1(1): loaded http://localhost:47317/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47317/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:25:56 INFO - PROCESS | 32568 | RSS: Main: 194846720 15:25:56 INFO - PROCESS | 32568 | 15:25:57 INFO - PROCESS | 32568 | Cycle 1(1): loaded http://localhost:47317/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47317/tests/kraken/driver.html?testName=ai-astar) 15:25:58 INFO - PROCESS | 32568 | RSS: Main: 197312512 15:25:58 INFO - PROCESS | 32568 | 15:25:58 INFO - PROCESS | 32568 | __start_tp_report 15:25:58 INFO - PROCESS | 32568 | _x_x_mozilla_page_load 15:25:58 INFO - PROCESS | 32568 | _x_x_mozilla_page_load_details 15:25:58 INFO - PROCESS | 32568 | |i|pagename|runs| 15:25:58 INFO - PROCESS | 32568 | |0;ai-astar;114;118;121;120;120;117;119;116;117;118 15:25:58 INFO - PROCESS | 32568 | |1;audio-beat-detection;153;127;123;175;127;125;126;129;154;128 15:25:58 INFO - PROCESS | 32568 | |2;audio-dft;171;175;163;164;163;163;163;164;165;165 15:25:58 INFO - PROCESS | 32568 | |3;audio-fft;76;77;77;124;78;78;79;76;105;78 15:25:58 INFO - PROCESS | 32568 | |4;audio-oscillator;82;83;126;85;83;83;102;83;84;115 15:25:58 INFO - PROCESS | 32568 | |5;imaging-gaussian-blur;119;118;119;117;119;118;118;118;118;119 15:25:58 INFO - PROCESS | 32568 | |6;imaging-darkroom;148;149;148;148;146;151;149;147;147;148 15:25:58 INFO - PROCESS | 32568 | |7;imaging-desaturate;97;97;96;95;95;95;97;96;96;96 15:25:58 INFO - PROCESS | 32568 | |8;json-parse-financial;63;65;63;65;65;71;64;64;64;64 15:25:58 INFO - PROCESS | 32568 | |9;json-stringify-tinderbox;66;68;66;67;67;67;66;67;66;67 15:25:58 INFO - PROCESS | 32568 | |10;stanford-crypto-aes;84;93;87;85;85;83;90;89;84;84 15:25:58 INFO - PROCESS | 32568 | |11;stanford-crypto-ccm;151;138;143;137;140;142;143;151;166;136 15:25:58 INFO - PROCESS | 32568 | |12;stanford-crypto-pbkdf2;176;182;179;177;172;174;174;172;185;172 15:25:58 INFO - PROCESS | 32568 | |13;stanford-crypto-sha256-iterative;72;73;71;70;69;70;69;71;71;67 15:25:58 INFO - PROCESS | 32568 | __end_tp_report 15:25:58 INFO - PROCESS | 32568 | __start_cc_report 15:25:58 INFO - PROCESS | 32568 | _x_x_mozilla_cycle_collect,856 15:25:58 INFO - PROCESS | 32568 | __end_cc_report 15:25:58 INFO - PROCESS | 32568 | __startTimestamp1475187958192__endTimestamp 15:25:58 INFO - PROCESS | 32568 | 15:25:58 INFO - PROCESS | 32568 | ------- Summary: start ------- 15:25:58 INFO - PROCESS | 32568 | Number of tests: 14 15:25:58 INFO - PROCESS | 32568 | 15:25:58 INFO - PROCESS | 32568 | [#0] ai-astar Cycles:10 Average:118.00 Median:118.50 stddev:2.11 (1.8%) stddev-sans-first:1.67 15:25:58 INFO - PROCESS | 32568 | Values: 114.0 118.0 121.0 120.0 120.0 117.0 119.0 116.0 117.0 118.0 15:25:58 INFO - PROCESS | 32568 | 15:25:58 INFO - PROCESS | 32568 | [#1] audio-beat-detection Cycles:10 Average:136.70 Median:128.50 stddev:17.62 (13.7%) stddev-sans-first:17.67 15:25:58 INFO - PROCESS | 32568 | Values: 153.0 127.0 123.0 175.0 127.0 125.0 126.0 129.0 154.0 128.0 15:25:58 INFO - PROCESS | 32568 | 15:25:58 INFO - PROCESS | 32568 | [#2] audio-dft Cycles:10 Average:165.60 Median:164.50 stddev:4.09 (2.5%) stddev-sans-first:3.84 15:25:58 INFO - PROCESS | 32568 | Values: 171.0 175.0 163.0 164.0 163.0 163.0 163.0 164.0 165.0 165.0 15:25:58 INFO - PROCESS | 32568 | 15:25:58 INFO - PROCESS | 32568 | [#3] audio-fft Cycles:10 Average:84.80 Median:77.50 stddev:16.31 (21.0%) stddev-sans-first:16.98 15:25:58 INFO - PROCESS | 32568 | Values: 76.0 77.0 77.0 124.0 78.0 78.0 79.0 76.0 105.0 78.0 15:25:58 INFO - PROCESS | 32568 | 15:25:58 INFO - PROCESS | 32568 | [#4] audio-oscillator Cycles:10 Average:92.60 Median:83.00 stddev:16.05 (19.3%) stddev-sans-first:16.56 15:25:58 INFO - PROCESS | 32568 | Values: 82.0 83.0 126.0 85.0 83.0 83.0 102.0 83.0 84.0 115.0 15:25:58 INFO - PROCESS | 32568 | 15:25:58 INFO - PROCESS | 32568 | [#5] imaging-gaussian-blur Cycles:10 Average:118.30 Median:118.50 stddev:0.67 (0.6%) stddev-sans-first:0.67 15:25:58 INFO - PROCESS | 32568 | Values: 119.0 118.0 119.0 117.0 119.0 118.0 118.0 118.0 118.0 119.0 15:25:58 INFO - PROCESS | 32568 | 15:25:58 INFO - PROCESS | 32568 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:1.37 (0.9%) stddev-sans-first:1.45 15:25:58 INFO - PROCESS | 32568 | Values: 148.0 149.0 148.0 148.0 146.0 151.0 149.0 147.0 147.0 148.0 15:25:58 INFO - PROCESS | 32568 | 15:25:58 INFO - PROCESS | 32568 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.78 15:25:58 INFO - PROCESS | 32568 | Values: 97.0 97.0 96.0 95.0 95.0 95.0 97.0 96.0 96.0 96.0 15:25:58 INFO - PROCESS | 32568 | 15:25:58 INFO - PROCESS | 32568 | [#8] json-parse-financial Cycles:10 Average:64.80 Median:64.50 stddev:2.30 (3.6%) stddev-sans-first:2.35 15:25:58 INFO - PROCESS | 32568 | Values: 63.0 65.0 63.0 65.0 65.0 71.0 64.0 64.0 64.0 64.0 15:25:58 INFO - PROCESS | 32568 | 15:25:58 INFO - PROCESS | 32568 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 15:25:58 INFO - PROCESS | 32568 | Values: 66.0 68.0 66.0 67.0 67.0 67.0 66.0 67.0 66.0 67.0 15:25:58 INFO - PROCESS | 32568 | 15:25:58 INFO - PROCESS | 32568 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:86.00 stddev:3.27 (3.8%) stddev-sans-first:3.35 15:25:58 INFO - PROCESS | 32568 | Values: 84.0 93.0 87.0 85.0 85.0 83.0 90.0 89.0 84.0 84.0 15:25:58 INFO - PROCESS | 32568 | 15:25:58 INFO - PROCESS | 32568 | [#11] stanford-crypto-ccm Cycles:10 Average:144.70 Median:143.00 stddev:9.12 (6.4%) stddev-sans-first:9.38 15:25:58 INFO - PROCESS | 32568 | Values: 151.0 138.0 143.0 137.0 140.0 142.0 143.0 151.0 166.0 136.0 15:25:58 INFO - PROCESS | 32568 | 15:25:58 INFO - PROCESS | 32568 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.30 Median:176.50 stddev:4.50 (2.5%) stddev-sans-first:4.77 15:25:58 INFO - PROCESS | 32568 | Values: 176.0 182.0 179.0 177.0 172.0 174.0 174.0 172.0 185.0 172.0 15:25:58 INFO - PROCESS | 32568 | 15:25:58 INFO - PROCESS | 32568 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:71.00 stddev:1.70 (2.4%) stddev-sans-first:1.69 15:25:58 INFO - PROCESS | 32568 | Values: 72.0 73.0 71.0 70.0 69.0 70.0 69.0 71.0 71.0 67.0 15:25:58 INFO - PROCESS | 32568 | -------- Summary: end -------- 15:25:58 INFO - PROCESS | 32568 | 15:25:59 INFO - TEST-INFO | 32568: exit 0 15:25:59 INFO - TEST-OK | kraken | took 65539ms 15:25:59 INFO - SUITE-END | took 1184s 15:25:59 INFO - Completed test suite (00:19:44) 15:25:59 INFO - javascript benchmark 15:25:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6252.911250090842, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2586.9094581689637, 2602.245348848834, 2611.099170786078, 2626.973730262697, 2651.2974061873606, 4510.143072816162, 4664.137134630096, 4686.648501362399, 4702.24764037754, 4723.07899959508, 4628.90742185157, 4662.0, 4688.554587314208, 4706.858794236178, 4742.051589682069, 4249.957500424987, 4292.570742925714, 4322.697411181219, 4371.235033869076, 4430.490493593245, 4335.284678028122, 4364.192624364487, 4367.301231802912, 4369.279068953619, 4415.139047885664, 4187.120704652027, 4238.978805105986, 4291.721038132543, 4313.590208930146, 4389.978050109729, 4313.1158112586845, 4353.673474489426, 4359.542248063939, 4414.690971631987, 4418.955810441887, 4298.097399546099, 4329.9134017319475, 4347.543507931685, 4357.150355680644, 4393.209222339978, 4568.109218702354, 4592.035672508777, 4723.740194289313, 4741.336212930192, 4803.423589169322, 5009.849704508871, 5066.771995260222, 5072.695638261716, 5077.26379674945, 5144.871378215537, 5110.540051395392, 5111.849610634378, 5119.820806271762, 5122.897542049175, 5171.4311425743135, 4608.9308660370125, 4765.26138448541, 4770.0, 4774.594159496447, 4825.372701548777, 5061.291419201315, 5098.1842905135, 5154.072266991902, 5159.174532074925, 5227.817026404134, 4964.304997300381, 4966.230234313687, 4977.0792403405485, 4982.078315511642, 5027.874303142451, 4796.352492413549, 4872.049950259736, 5033.974830125826, 5062.721550314768, 5064.518870707277, 5039.143345631178, 5052.747362631853, 5068.037072956126, 5111.258867464271, 5129.743512824344, 5026.346574945307, 5042.798288068436, 5046.949530504721, 5052.368453943257, 5112.284280200774, 4239.59723826236, 4305.117450922553, 4360.520342762294, 4362.890927726832, 4420.823167073346, 3756.323861704919, 3782.3002744492355, 3784.9432258516144, 3828.464015037897, 3882.4176373544196, 4416.3596278539435, 4418.756968366771, 4434.955650443454, 4436.733795972252, 4466.883279180205, 4916.311716359713, 5068.746562671851, 5094.083065048327, 5125.15434953236, 5134.897302053938, 4289.420928174656, 4351.19502891966, 4379.934300985424, 4412.624926881251, 4451.5103338632725, 4580.26715725489, 4595.586397224199, 4597.7011494252765, 4602.861914142581, 4660.5106463821485, 4794.5924596409695, 4804.975975120102, 4805.087033463631, 4807.927881081787, 4864.051509955525, 4917.237828136645, 4968.105740966661, 5003.824866129668, 5055.848324550269, 5064.113780088396, 4715.764211789466, 4721.22099853534, 4726.031163611383, 4770.189067858541, 4774.0, 4898.755062246944, 4906.582940450102, 4906.705597664151, 4921.212605983025, 4971.502849715, 4918.286848407032, 4968.0, 4987.6508644396, 5007.273945277987, 5025.020121076355, 4907.411110666742, 4917.360743103373, 4918.2376731606655, 4968.975155124346, 4978.352814134139, 4681.391419115494, 4854.63590230727, 4856.077345304381, 4905.23968784839, 4968.900621987467, 4648.976755116203, 4655.068986202706, 4720.5043470436485, 4828.203346447796, 4885.926711099408, 4919.508049195052, 4925.0, 4934.333864928189, 4946.826861059845, 5011.824586139468, 4824.95175048245, 4836.298736683231, 4836.492168322276, 4844.903101938012, 4909.631777616764], "value": 4634.6962382408665, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.1722598875698, 556.5519756595941, 558.012318196792, 564.2016546586581, 568.2328856044338, 38317.616823831755, 40282.39576406353, 40292.798536007314, 43393.0, 43409.0, 39996.200075998466, 40445.595544044554, 40498.59501404985, 40701.59298407015, 40713.0, 7605.619719014041, 7719.073711154641, 7734.419918506106, 7736.34241089508, 7750.14748377678, 7673.961630191841, 7760.146383897767, 7762.107357653886, 7780.766577002699, 7783.688652453923, 7761.068671759369, 7796.844063118734, 7809.297163255306, 7812.960935195316, 7828.725994590191, 7702.961485192566, 7728.574928378937, 7769.456138070337, 7789.649465774054, 7794.922050779476, 7660.0, 7709.0, 7735.110462296795, 7739.883901741478, 7749.186335434754, 37345.25309493795, 37451.81274093612, 37481.43777843335, 37601.24797504034, 37623.435648465296, 2862.685104638488, 2897.377063931244, 3197.344544368399, 3607.837647305851, 3650.0, 28197.85901070502, 28325.57511637327, 28746.568801467994, 30765.692343076505, 31494.842525787226, 3144.921376965571, 3204.214967333018, 3250.9837450812593, 3276.8689252429876, 3278.2623909620384, 247681.0, 248001.9999999982, 248306.0, 248573.0, 249466.0, 53529.0, 53592.83682376576, 53640.73179634077, 53668.19497707538, 53859.19211211835, 31881.202969925474, 32486.187845304055, 32543.0, 34686.47970280448, 34883.12792180216, 12892.355382230851, 12907.161034532724, 12920.806187907188, 12923.483060677467, 12949.0, 10206.438645874548, 10239.18086553074, 10270.845937310947, 10276.126529244948, 10311.9484402579, 17487.825121748872, 17614.383496577557, 17645.470635880945, 17647.294108235783, 17737.822621773874, 6715.597064176165, 6781.830454238585, 7007.754728584475, 7010.263922288188, 7050.541714788523, 762.897008903802, 810.9716159934374, 918.875951746519, 928.6331898899897, 990.5641517732175, 25736.613950790754, 28028.0, 28058.71941280561, 28241.0, 28419.152755070852, 942.2320808541017, 949.6154057606681, 992.5235886774244, 1044.9164066874632, 1094.2996482251365, 14066.507672231422, 14984.850151498564, 14990.400383984737, 15206.239688015556, 15219.543413697607, 397555.0, 401393.0, 402004.0, 402668.0, 403563.0, 48537.757311213216, 48932.0, 49003.0, 49118.75440622846, 49307.0, 1128.1257025805066, 1155.8439610652622, 1159.5072094359864, 1163.8836116388463, 1197.9401029948642, 26127.869360653076, 26947.326316842235, 27587.586186207624, 27789.30526736767, 27891.302717432227, 41214.79392603138, 41344.586554134075, 41348.793256033525, 41378.1724365505, 41481.1703765917, 302780.0, 304623.0, 306080.0, 306246.0, 307872.0, 24620.6306905393, 25014.0, 25274.0, 25296.367590810376, 25308.0, 40150.0, 41076.79461602673, 41883.581164189185, 41913.37129942992, 42158.1568368637, 35599.64400355963, 35852.82073589615, 36029.63970360263, 36375.634264003165, 36697.44953825748, 35826.820865895505, 35835.0, 36004.639953600126, 36380.0, 36922.26155476929, 30830.0, 31486.055418337488, 34703.826480867436, 35241.82379088191, 36087.45868811917, 27665.0, 31935.520967185046, 32194.35611287808, 32718.672813272515, 32774.1806454831, 24577.877110614332, 24734.752652473246, 24898.377540561632, 25210.873945630887, 25349.873250633627], "value": 17059.531512802503, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.54299410766, 366.6260414377334, 372.2443439817171, 377.2059814091339, 392.2958289869684, 15248.695026099485, 16327.428540001103, 16612.91693541532, 16746.413875514358, 16813.579660508494, 13779.931100344484, 14857.479988200415, 14964.700705985873, 14988.175650339253, 15024.399024039052, 4661.860144195671, 5046.899062018758, 5073.0107629012355, 5077.720725360104, 5079.517445842639, 3705.499757532739, 3848.730588858781, 5015.648904576663, 5716.971415142919, 6020.789272375468, 6044.063170208603, 6074.362191969846, 6084.5436592255755, 6087.2086628738425, 6093.390660933894, 5817.214676018725, 6012.8496787580225, 6043.0331147016705, 6043.425874541911, 6044.153818465418, 4590.839320623795, 5283.973580132113, 5300.469953004707, 5302.0721373759825, 5304.840854774363, 12082.637520874388, 14429.989900706954, 18257.360992365335, 19883.30408435698, 19884.304049358205, 1729.2996336483743, 1839.6964500857343, 2142.06820033286, 2238.541099074686, 2281.498070424504, 8685.435446696009, 8720.52037137957, 9064.229540489066, 9065.637374505011, 9446.763830904214, 1652.9090900000494, 1722.1389305347327, 1729.437932671874, 1731.4892106828515, 1771.1498480729194, 64703.0, 66215.3378466214, 68740.65629671869, 69324.6533767328, 70261.0, 9363.063693630582, 9441.339106262496, 9492.382995105296, 9671.613135474643, 9720.854187187198, 12911.870881291256, 12946.287954162422, 12957.611271661677, 12984.091113621957, 13034.543790967271, 6647.202335719745, 6868.656567171622, 6973.860522789516, 7029.0862187915245, 7054.470914681317, 6452.870942581216, 6547.869042619121, 6574.441172500391, 6721.529492935448, 6724.831879203059, 4010.979945100256, 4059.0, 4090.570490098497, 4155.317096575892, 4156.521999969982, 1431.6420894776306, 1528.3580896023698, 1555.587769241152, 1851.8703690741788, 1854.9258029678663, 788.113372455987, 819.9180081991753, 869.2741560796806, 875.7066382761719, 885.3890815337396, 15468.149251791034, 15646.2176891155, 16415.26131324093, 16457.835421645632, 17057.402990895258, 796.9960150199328, 838.4256784102909, 847.174339298812, 857.0972441180569, 878.7539488943106, 8970.282377409922, 9059.320550958704, 9548.278740558908, 9609.837786497981, 9613.807723845484, 351785.0, 353303.0, 355712.0, 365570.0, 383014.0, 74307.62846185734, 75475.24524754792, 75693.0, 76213.61893190499, 76438.23561764423, 911.3483859040817, 927.3971918253189, 953.7901661634429, 954.9734035911423, 955.4458414119794, 13825.239611821446, 14841.554753357417, 14932.925335373253, 15085.094894306376, 15482.690346193238, 35040.47439288362, 35924.82037589795, 36403.63596364002, 36857.0, 37140.44289335716, 47364.52635473739, 48891.0, 49177.50822491729, 50451.0, 50929.490705092474, 6996.860062798613, 7274.927250727636, 7300.050993370828, 7475.813104672427, 7597.3162415382885, 9767.609295628095, 11475.655730328104, 11565.363904985306, 11706.531738730697, 11974.58088966882, 4891.926621100615, 4989.151844186425, 8830.42602230853, 9657.22742180638, 10174.186065114922, 9126.589303481493, 9935.801283974135, 10017.198624110199, 10180.490975451346, 10318.43248621333, 9180.632774689206, 10064.0, 10206.693799186036, 10250.846237306298, 10382.584696612052, 7256.2743725629125, 7320.560766354036, 7336.816579585553, 7407.851842963219, 7559.659815308434, 6912.983321928146, 9281.257499399897, 9357.953210234178, 9532.66635667776, 9535.618575256913], "value": 7864.663196807972, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1326.661701266177, 1381.43361221899, 1429.8427173010973, 1658.8424099710523, 1663.667266546691, 6267.968660156705, 6519.90220146697, 7021.22766495685, 7591.962040189798, 7607.961960190199, 7068.2931706829295, 7336.926630733691, 7341.192468828424, 7535.698572057111, 7541.170471248159, 2101.831853451724, 2123.2568600989684, 2126.25581046634, 2126.606577783115, 2133.2746866065536, 2048.3138148720195, 2067.2454554087726, 2068.782777808331, 2072.9481762955897, 2093.602215579043, 2051.640962831506, 2062.927797527087, 2069.430906500717, 2071.337172104927, 2073.512724509739, 2038.9898050509726, 2048.3138148720195, 2048.9077991490417, 2052.558699879518, 2056.7737548869613, 1995.0523501336893, 2000.779914209436, 2006.2877678424095, 2014.244658253155, 2017.213286818142, 7224.494285400024, 7329.926700732978, 7330.926690733131, 7331.853362932765, 7343.0, 4155.335146376596, 4259.403683484315, 4272.081502476983, 4289.420928174719, 4289.442372491588, 2735.7948153888537, 2750.821196622213, 2812.3812761192503, 2874.195225336909, 2891.7252860978174, 873.7335112790596, 886.3263919421222, 908.5593487158723, 932.7761337279072, 937.1144268666113, 9793.951030244874, 9800.90199098007, 9900.702978910644, 9918.553665085088, 9919.404835709809, 3791.374423220193, 3843.8462461501786, 4027.8993025174605, 4035.071933455322, 4040.5353384361174, 8337.333013359039, 8356.70751523706, 8359.623816928253, 8360.205780450848, 8363.540005299767, 4402.757848318373, 4455.220336441174, 4455.287154055401, 4457.4205353304515, 4470.687051906335, 3434.4504879219203, 3561.6794488495643, 3924.6075392460525, 4066.8169932352525, 4091.1408604193452, 3402.1834759657504, 3447.1554469154717, 3609.873654422135, 3624.0758606555687, 3640.0899775056237, 1126.3393969598803, 1143.1826244235413, 1146.489812033637, 1199.1126566340845, 1200.8198770184542, 791.6160662078887, 794.8450052239758, 797.8643630582815, 814.3770015937812, 820.6143112737004, 4881.902361952741, 4983.476734942778, 5047.343845300161, 5095.490450954875, 5096.439391666913, 383.8963479860422, 390.0463367067549, 390.3715018819698, 392.24297106584567, 393.4531001907351, 3384.966150338514, 3389.796612203276, 3391.542141810873, 3397.8301084945656, 3489.616142224353, 8754.518501482353, 9003.0, 9073.45559266446, 9076.455412675261, 9092.499912504876, 8918.955405222932, 8934.151255630704, 8941.37410381267, 8946.239569636524, 8951.283897288331, 6952.826179345557, 6956.130483689539, 6994.2656021117045, 7008.404285635676, 7034.331738484836, 4797.832075877328, 4863.610911127172, 4871.415430148405, 4927.704337739604, 5019.598432125495, 8100.554469504234, 8240.83518329642, 8325.916740832514, 8355.0, 8374.916250837658, 8373.0, 8408.2432581068, 8408.747737567883, 8440.324774017941, 8468.247819458576, 5581.49766521015, 5758.107493338539, 6272.0, 6299.30707622152, 6398.71205795731, 6786.898196526958, 7017.929820701932, 7055.506114571931, 7240.167380751281, 7260.092488438945, 6464.870702586016, 6481.578697384655, 6510.348965103642, 6672.933270667231, 6680.164979377578, 6224.910640637961, 6266.874662506633, 6270.874582508415, 6290.1508296381235, 6316.494680425463, 5665.291838520185, 5759.8560035999435, 5804.158397032322, 5816.505597024131, 5817.0, 4160.417541544247, 4230.492340918986, 4261.488621365332, 4303.203907277164, 4394.560543945579, 4281.892952676208, 4336.761478118734, 4375.081232941118, 4384.583464570861, 4499.550044995474], "value": 3833.593245217692, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [278.94839454700883, 286.32427471168046, 288.97688184945207, 289.4197134744836, 298.3317369093231, 4792.8497160681445, 4911.084676975982, 4915.926261106082, 5001.749912504374, 5019.849404517861, 4745.833895813647, 4813.518648135185, 4857.587105096062, 4870.902581948359, 4891.510848915107, 3831.252905683393, 3874.9806250968845, 3880.6313400227073, 3888.51393575803, 3907.8241479133508, 3639.909002274938, 3873.612638736132, 3890.6692931100893, 3903.9609603904023, 3904.472896159025, 3778.619469734064, 3796.1838204785968, 3804.744434336676, 3807.409851473012, 3845.288621605012, 3791.49761157636, 3792.317382871096, 3812.8093595320124, 3818.1981783825154, 3828.6937045036607, 3314.850831712579, 3330.5670262865915, 3339.866405343808, 3340.2150494633743, 3341.6992470677756, 4707.905841883177, 4764.2615394613895, 4784.64115191362, 4820.276958456225, 4847.351900353861, 4319.436464916425, 4342.891427714301, 4344.608985191317, 4345.69580129391, 4354.738715677038, 5150.510701483353, 5151.381834179922, 5169.896602067975, 5177.948220517785, 5188.5849132069725, 3411.9488207676904, 3613.0, 3616.4032934565766, 3635.4910312556262, 3640.8179591020344, 5301.118103073392, 5383.75773090208, 5385.976664433745, 5386.111291636876, 5389.649672771257, 3675.044488432973, 3683.4290684943876, 3686.7419280650633, 3693.0, 3697.685696715809, 3719.1631882826146, 3720.1815600567834, 3724.510195921653, 3729.533808273966, 3731.2910546996527, 4186.162767446523, 4236.915261694749, 4279.272523670983, 4280.850170244026, 4293.141371725667, 5174.896502069938, 5182.948170518246, 5185.507376799198, 5189.40321862983, 5201.505856943584, 1190.4404929683035, 1214.7488087270126, 1263.829383033297, 1266.5693664154232, 1289.4584274604688, 857.1642648417743, 866.5927014303268, 884.7390019944132, 886.8182022685334, 891.3760367742606, 4566.383538222364, 4583.816647334069, 4584.9312260315455, 4586.4266966629175, 4586.701864378805, 5300.429291793477, 5320.388155362183, 5325.254464374913, 5328.547073498718, 5332.10710197882, 4578.9771051144535, 4582.518835522289, 4586.610138138229, 4590.42619672541, 4590.816367345269, 2707.7156898525764, 2837.90067347646, 2840.7358725367426, 2851.4867323881485, 2854.6146270253666, 5036.395632524121, 5053.646244762905, 5056.595472362203, 5064.442911279756, 5086.135356989321, 5289.312389389354, 5491.2312276281355, 5491.341039075336, 5496.258005169331, 5501.889962200814, 5018.8920653325695, 5042.856785866065, 5055.797768089235, 5059.241113832954, 5063.569596584258, 5360.571154307568, 5363.436839131835, 5368.469986053956, 5373.731313434235, 5379.973100134631, 5049.192129259301, 5244.7902083916215, 5245.763940622604, 5253.50091741284, 5258.395284542326, 5020.472850350807, 5031.798728050983, 5052.46949070357, 5056.924146137737, 5073.6702114363925, 3632.3643362410944, 3647.8723244686307, 3663.487111804296, 3663.9816800915823, 3668.3396988541253, 5141.460146684693, 5331.733413329395, 5333.919991200212, 5365.678059316453, 5407.729613519387, 5272.630915836008, 5276.707206734374, 5281.0, 5286.20706893969, 5297.682139071668, 5262.789488420421, 5279.128943724242, 5306.0, 5327.440618735132, 5344.786208551614, 5038.129890843871, 5062.645614806928, 5131.076406246762, 5187.213334265932, 5203.635745497779, 5245.895082098413, 5259.658122222043, 5272.815451459181, 5274.578033757213, 5280.5445467857635, 5175.792968281377, 5180.637355385237, 5199.272101905812, 5201.193814958688, 5202.1416466282635], "value": 3881.925834061505, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.7102190948344, 642.9067785171151, 714.0610097721494, 722.7181399254292, 737.9372753315968, 12505.937470312647, 12711.618651440449, 13000.73998520029, 13031.739365212701, 13103.868961310383, 12720.745585088293, 13029.804552931713, 13071.73856522869, 13092.214467131978, 13121.212727236372, 633.1104797759156, 734.8493558820443, 765.7434759355623, 776.6854423958306, 776.8407476467311, 644.7292137302321, 748.5920173505452, 772.1622040086513, 776.409928454376, 778.1906816910434, 814.0394334685069, 818.8689809630431, 819.1808191808192, 819.5001049359886, 820.0118856777568, 801.8075661841175, 801.9278264956124, 814.0760237130839, 814.1817473439186, 814.352589691194, 584.6141546579237, 585.0288521055028, 587.1984740828781, 591.1516973143509, 592.1561774471404, 12190.08574356918, 12200.633980980585, 12210.145289829716, 12274.202176858566, 12275.324857132855, 13095.345232738326, 13459.259740714257, 13720.0, 13857.722845543032, 13982.0, 10377.221708371902, 10379.858215596278, 10435.79128417435, 10528.684139475752, 10558.472076396149, 3305.1076209423322, 3329.433996220648, 3337.6161741399806, 3375.578052743407, 3383.7462190335577, 62461.0, 63119.684401577695, 63178.68410657963, 64361.67819160874, 65335.3466465334, 8942.195202431682, 9801.509924503745, 9850.261230407748, 10102.242331824995, 10278.074973252444, 16856.241469133918, 17169.7424538632, 17170.742438863428, 17189.914050429918, 17200.31198752061, 6402.0, 6647.734090636417, 6721.6975236114495, 7058.752943646948, 7200.891986620205, 3538.327717733622, 3568.3220188164164, 3582.982085089558, 3667.8716244931297, 3887.727859049896, 2777.972220277771, 2856.0860524632335, 2869.0818937940076, 2876.6260386150084, 2877.6690680571583, 498.5961371289267, 498.6110833549837, 501.5786739139141, 519.4000928927095, 526.147640821871, 473.39405560882125, 571.9942800572024, 572.5591294703139, 579.9275090613673, 587.3539106982371, 7348.225284398307, 7576.886346704804, 7899.526028438312, 8025.117237103914, 8146.67413303473, 488.274911756042, 501.5811797149348, 505.1513457391544, 507.69015938878346, 588.4733163818358, 4075.5924407559005, 4260.2176253727885, 4333.479982402132, 4384.868453946387, 4449.866504004885, 90062.54968725114, 92386.0, 94359.0, 97405.0, 97851.0, 63808.68095659585, 66390.0, 77434.61282693663, 78341.60829195932, 81633.18366816256, 43616.563834361885, 57620.42379576234, 66514.66742666352, 66936.330636693, 67524.3247567518, 8617.439866408664, 8926.776830579287, 9050.547472626211, 9059.954700226457, 9132.908670913206, 42311.3653295207, 42434.60523158078, 42951.355729664705, 43438.0, 44974.55025449704, 47239.055218896116, 54112.45887541232, 54403.0, 54516.727416362664, 61817.38182618116, 11035.779284414106, 11053.557857685602, 11124.499397526968, 11141.387223702774, 11522.596709115141, 12995.545155919497, 13098.738025239632, 13401.66495837612, 13478.52825151115, 13814.102083364549, 11857.433546387472, 11907.940460297643, 12272.570460033856, 12786.232826030468, 12882.420291086735, 11899.940500297444, 11949.880501195224, 12573.1198816082, 12607.747845043232, 12615.558455454015, 12090.335031573348, 12238.388080595756, 12609.621711348675, 12756.48974041028, 12874.098813083368, 9857.211423085993, 10080.798384032425, 10132.544035518567, 10287.331323463952, 10987.725306867393, 9806.75483112928, 10613.09788667972, 10711.464426778786, 10726.463676816284, 10764.246502745045], "value": 6458.352876732327, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1569.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 118.0, 121.0, 120.0, 120.0, 117.0, 119.0, 116.0, 117.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 127.0, 123.0, 175.0, 127.0, 125.0, 126.0, 129.0, 154.0, 128.0], "value": 136.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 175.0, 163.0, 164.0, 163.0, 163.0, 163.0, 164.0, 165.0, 165.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 124.0, 78.0, 78.0, 79.0, 76.0, 105.0, 78.0], "value": 84.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 126.0, 85.0, 83.0, 83.0, 102.0, 83.0, 84.0, 115.0], "value": 92.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 119.0, 117.0, 119.0, 118.0, 118.0, 118.0, 118.0, 119.0], "value": 118.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 148.0, 148.0, 146.0, 151.0, 149.0, 147.0, 147.0, 148.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 96.0, 95.0, 95.0, 95.0, 97.0, 96.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 63.0, 65.0, 65.0, 71.0, 64.0, 64.0, 64.0, 64.0], "value": 64.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 66.0, 67.0, 67.0, 67.0, 66.0, 67.0, 66.0, 67.0], "value": 66.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 93.0, 87.0, 85.0, 85.0, 83.0, 90.0, 89.0, 84.0, 84.0], "value": 86.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 138.0, 143.0, 137.0, 140.0, 142.0, 143.0, 151.0, 166.0, 136.0], "value": 144.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 182.0, 179.0, 177.0, 172.0, 174.0, 174.0, 172.0, 185.0, 172.0], "value": 176.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 71.0, 70.0, 69.0, 70.0, 69.0, 71.0, 71.0, 67.0], "value": 70.3, "unit": "score"}]}]} 15:25:59 INFO - Return code: 0 15:25:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:25:59 ERROR - # TBPL SUCCESS # 15:25:59 INFO - Running post-action listener: _resource_record_post_action 15:25:59 INFO - [mozharness: 2016-09-29 22:25:59.986655Z] Finished run-tests step (success) 15:25:59 INFO - Running post-run listener: _resource_record_post_run 15:26:00 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 0; Write bytes: 406315008; Read time: 0; Write time: 262816 15:26:00 INFO - TinderboxPrint: CPU usage
13.4% 15:26:00 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 15:26:00 INFO - TinderboxPrint: I/O write bytes / time
406,315,008 / 262,816 15:26:00 INFO - TinderboxPrint: CPU idle
8,296.5 (86.6%) 15:26:00 INFO - TinderboxPrint: CPU user
1,218.6 (12.7%) 15:26:00 INFO - TinderboxPrint: Swap in / out
0 / 0 15:26:00 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99901440; Read time: 0; Write time: 80036 15:26:00 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 289849344; Read time: 0; Write time: 178128 15:26:00 INFO - Running post-run listener: _upload_blobber_files 15:26:00 INFO - Blob upload gear active. 15:26:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:26:00 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:26:00 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:26:00 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:26:01 INFO - (blobuploader) - INFO - Open directory for files ... 15:26:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:26:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:26:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:26:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:26:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:26:06 INFO - (blobuploader) - INFO - Done attempting. 15:26:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:26:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:26:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:26:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:26:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:26:07 INFO - (blobuploader) - INFO - Done attempting. 15:26:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:26:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:26:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:26:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:26:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:26:08 INFO - (blobuploader) - INFO - Done attempting. 15:26:08 INFO - (blobuploader) - INFO - Iteration through files over. 15:26:08 INFO - Return code: 0 15:26:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:26:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:26:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c449e7a77af1108627cc57d7cf00da3075b9cfecfc9d97957f07b255aef1692c3981de0d073f656327299ff8c68240a0ce11604db73a0ccf733604491aa0ee6b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3d48dd635f488cc32905721f4873d89739d9b28de4e5d3fb0ad7415bedb6319131b883d04f544a866f685fc9ee23b6b2caa6202b1a23118db6372e2233657002", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/181af9cc7d7760246c0be1fd3b814f1cd3fb7c3ef692b85e59c61cccb64b206f364e07d95ce0c1832e9b76f67acce8720d9035319a4960b91b514913e04bf5c7"} 15:26:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:26:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:26:08 INFO - Contents: 15:26:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c449e7a77af1108627cc57d7cf00da3075b9cfecfc9d97957f07b255aef1692c3981de0d073f656327299ff8c68240a0ce11604db73a0ccf733604491aa0ee6b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3d48dd635f488cc32905721f4873d89739d9b28de4e5d3fb0ad7415bedb6319131b883d04f544a866f685fc9ee23b6b2caa6202b1a23118db6372e2233657002", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/181af9cc7d7760246c0be1fd3b814f1cd3fb7c3ef692b85e59c61cccb64b206f364e07d95ce0c1832e9b76f67acce8720d9035319a4960b91b514913e04bf5c7"} 15:26:08 INFO - Running post-run listener: copy_logs_to_upload_dir 15:26:08 INFO - Copying logs to upload dir... 15:26:08 INFO - mkdir: /builds/slave/test/build/upload/logs 15:26:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.968105 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-09-29 15:26:08.344440) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-29 15:26:08.348096) ========= 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=8887e36bb8e381bfd44124ac000001a8-1475185853.26066-1079958624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c449e7a77af1108627cc57d7cf00da3075b9cfecfc9d97957f07b255aef1692c3981de0d073f656327299ff8c68240a0ce11604db73a0ccf733604491aa0ee6b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3d48dd635f488cc32905721f4873d89739d9b28de4e5d3fb0ad7415bedb6319131b883d04f544a866f685fc9ee23b6b2caa6202b1a23118db6372e2233657002", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/181af9cc7d7760246c0be1fd3b814f1cd3fb7c3ef692b85e59c61cccb64b206f364e07d95ce0c1832e9b76f67acce8720d9035319a4960b91b514913e04bf5c7"} build_url:https://queue.taskcluster.net/v1/task/OICit1p9Q2mHldHrzJlp-Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011507 build_url: 'https://queue.taskcluster.net/v1/task/OICit1p9Q2mHldHrzJlp-Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c449e7a77af1108627cc57d7cf00da3075b9cfecfc9d97957f07b255aef1692c3981de0d073f656327299ff8c68240a0ce11604db73a0ccf733604491aa0ee6b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3d48dd635f488cc32905721f4873d89739d9b28de4e5d3fb0ad7415bedb6319131b883d04f544a866f685fc9ee23b6b2caa6202b1a23118db6372e2233657002", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/181af9cc7d7760246c0be1fd3b814f1cd3fb7c3ef692b85e59c61cccb64b206f364e07d95ce0c1832e9b76f67acce8720d9035319a4960b91b514913e04bf5c7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-29 15:26:08.374363) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 15:26:08.374771) ========= 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=8887e36bb8e381bfd44124ac000001a8-1475185853.26066-1079958624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004505 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 15:26:08.458751) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-29 15:26:08.459115) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-29 15:26:08.459463) ========= ========= Total master_lag: 0.19 =========